[21:17:16.331] New invocation is queued and will start shortly
[21:17:17.822] Starting the invocation (attempt 1)
[21:17:17.848] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/quickstart/bazel/+/186223f773e7b2285d47a04a16e98108d15d5198"
[21:17:17.848] Popped gitiles commit info from properties and tags
[21:17:17.848] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:17:17.849] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:17:17.849] Buildbucket request:
{
"requestId": "8880925741826726400",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880925741826726400",
"job": "pigweed/quickstart.dev.ci-quickstart-cmake-linux-build",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "186223f773e7b2285d47a04a16e98108d15d5198"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@186223f773e7b2285d47a04a16e98108d15d5198",
"title": "186223f773e7b2285d47a04a16e98108d15d5198",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/186223f773e7b2285d47a04a16e98108d15d5198"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "186223f773e7b2285d47a04a16e98108d15d5198",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880925741826726400"
},
{
"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"
}
}
[21:17:18.288] Scheduled build:
{
"id": "8715495679508771089",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"createdBy": "project:pigweed",
"createTime": "2025-05-07T21:17:17.910898913Z",
"updateTime": "2025-05-07T21:17:17.910898913Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "186223f773e7b2285d47a04a16e98108d15d5198",
"ref": "refs/heads/main"
}
}
}
[21:17:18.288] Task URL: https://cr-buildbucket.appspot.com/build/8715495679508771089
[21:17:18.288] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:2:0) after 1m49s
[21:17:19.198] Received PubSub notification, asking Buildbucket for the build status
[21:17:19.243] Build status: SCHEDULED
[21:19:07.310] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:2:0)
[21:19:07.336] Build status: SCHEDULED
[21:19:07.336] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:4:0) after 3m12s
[21:22:19.387] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:4:0)
[21:22:19.427] Build status: SCHEDULED
[21:22:19.427] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:5:0) after 2m40s
[21:24:59.441] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:5:0)
[21:24:59.640] Build status: SCHEDULED
[21:24:59.640] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:6:0) after 1m26s
[21:26:25.670] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:6:0)
[21:26:25.723] Build status: SCHEDULED
[21:26:25.723] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:7:0) after 9m15s
[21:35:40.746] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:7:0)
[21:35:40.796] Build status: SCHEDULED
[21:35:40.796] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:8:0) after 1m21s
[21:37:01.930] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:8:0)
[21:37:01.960] Build status: SCHEDULED
[21:37:01.961] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:9:0) after 7m12s
[21:44:13.984] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:9:0)
[21:44:14.021] Build status: SCHEDULED
[21:44:14.021] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:10:0) after 5m23s
[21:49:37.147] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:10:0)
[21:49:37.191] Build status: SCHEDULED
[21:49:37.191] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:11:0) after 4m26s
[21:54:03.330] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:11:0)
[21:54:03.465] Build status: SCHEDULED
[21:54:03.465] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:12:0) after 4m35s
[21:58:38.534] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:12:0)
[21:58:38.574] Build status: SCHEDULED
[21:58:38.574] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:13:0) after 4m42s
[22:03:20.551] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:13:0)
[22:03:20.571] Build status: SCHEDULED
[22:03:20.571] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:14:0) after 5m58s
[22:09:18.668] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:14:0)
[22:09:18.698] Build status: SCHEDULED
[22:09:18.698] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:15:0) after 3m50s
[22:13:08.780] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:15:0)
[22:13:08.798] Build status: SCHEDULED
[22:13:08.798] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:16:0) after 5m35s
[22:18:43.826] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:16:0)
[22:18:43.844] Build status: SCHEDULED
[22:18:43.844] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:17:0) after 9m13s
[22:27:57.001] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:17:0)
[22:27:57.019] Build status: SCHEDULED
[22:27:57.019] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:18:0) after 6m18s
[22:34:15.039] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:18:0)
[22:34:15.066] Build status: SCHEDULED
[22:34:15.066] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:19:0) after 5m53s
[22:40:08.083] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:19:0)
[22:40:08.112] Build status: SCHEDULED
[22:40:08.112] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:20:0) after 9m23s
[22:49:31.139] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:20:0)
[22:49:31.180] Build status: SCHEDULED
[22:49:31.180] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:21:0) after 5m5s
[22:54:36.197] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:21:0)
[22:54:36.218] Build status: SCHEDULED
[22:54:36.218] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:22:0) after 6m0s
[23:00:36.222] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:22:0)
[23:00:36.249] Build status: SCHEDULED
[23:00:36.249] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:23:0) after 2m9s
[23:02:45.271] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:23:0)
[23:02:45.301] Build status: SCHEDULED
[23:02:45.301] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:24:0) after 8m44s
[23:11:29.275] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:24:0)
[23:11:29.303] Build status: SCHEDULED
[23:11:29.303] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:25:0) after 6m15s
[23:17:44.329] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:25:0)
[23:17:44.353] Build status: SCHEDULED
[23:17:44.353] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:26:0) after 4m55s
[23:22:39.409] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:26:0)
[23:22:39.425] Build status: SCHEDULED
[23:22:39.425] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:27:0) after 1m22s
[23:24:01.462] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:27:0)
[23:24:01.493] Build status: SCHEDULED
[23:24:01.493] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:28:0) after 9m33s
[23:33:34.588] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:28:0)
[23:33:34.613] Build status: SCHEDULED
[23:33:34.613] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:29:0) after 4m19s
[23:37:53.641] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:29:0)
[23:37:53.660] Build status: SCHEDULED
[23:37:53.660] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:30:0) after 4m10s
[23:42:04.026] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:30:0)
[23:42:04.049] Build status: SCHEDULED
[23:42:04.049] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:31:0) after 4m13s
[23:46:17.235] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:31:0)
[23:46:17.261] Build status: SCHEDULED
[23:46:17.261] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:32:0) after 4m0s
[23:50:17.285] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:32:0)
[23:50:17.305] Build status: SCHEDULED
[23:50:17.305] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:33:0) after 8m14s
[23:58:31.339] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:33:0)
[23:58:31.358] Build status: SCHEDULED
[23:58:31.358] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:34:0) after 9m0s
[00:07:31.374] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:34:0)
[00:07:31.401] Build status: SCHEDULED
[00:07:31.401] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:35:0) after 1m40s
[00:09:11.454] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:35:0)
[00:09:11.532] Build status: SCHEDULED
[00:09:11.532] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:36:0) after 7m53s
[00:17:04.990] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:36:0)
[00:17:05.062] Build status: SCHEDULED
[00:17:05.062] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:37:0) after 7m53s
[00:24:58.090] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:37:0)
[00:24:58.118] Build status: SCHEDULED
[00:24:58.118] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:38:0) after 2m57s
[00:27:55.147] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:38:0)
[00:27:55.188] Build status: SCHEDULED
[00:27:55.188] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:39:0) after 9m36s
[00:37:31.243] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:39:0)
[00:37:31.294] Build status: SCHEDULED
[00:37:31.295] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:40:0) after 1m28s
[00:38:59.378] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:40:0)
[00:38:59.681] Build status: SCHEDULED
[00:38:59.681] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:41:0) after 4m48s
[00:43:47.753] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:41:0)
[00:43:47.785] Build status: SCHEDULED
[00:43:47.785] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8880925741826726400:42:0) after 2m22s
[00:44:46.824] Received PubSub notification, asking Buildbucket for the build status
[00:44:46.852] Build status: STARTED
[00:45:05.193] Received PubSub notification, asking Buildbucket for the build status
[00:45:05.213] Build:
{
"id": "8715495679508771089",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"createdBy": "project:pigweed",
"createTime": "2025-05-07T21:17:17.910898913Z",
"startTime": "2025-05-08T00:44:46.439974073Z",
"endTime": "2025-05-08T00:45:04.896518547Z",
"updateTime": "2025-05-08T00:45:04.896518547Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "186223f773e7b2285d47a04a16e98108d15d5198",
"ref": "refs/heads/main"
}
}
}
[00:45:05.213] Invocation finished in 3h27m48.89698409s with status FAILED