[17:46:02.319] New invocation is queued and will start shortly
[17:46:03.456] Starting the invocation (attempt 1)
[17:46:03.480] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/quickstart/bazel/+/71336775a69224e1d2403e49bb5e26ab8c8cfdbe"
[17:46:03.480] Popped gitiles commit info from properties and tags
[17:46:03.480] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:46:03.480] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:46:03.480] Buildbucket request:
{
"requestId": "8873419483279949184",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873419483279949184",
"job": "pigweed/quickstart.dev.ci-quickstart-cmake-linux-build",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "71336775a69224e1d2403e49bb5e26ab8c8cfdbe"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@71336775a69224e1d2403e49bb5e26ab8c8cfdbe",
"title": "71336775a69224e1d2403e49bb5e26ab8c8cfdbe",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/71336775a69224e1d2403e49bb5e26ab8c8cfdbe"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "71336775a69224e1d2403e49bb5e26ab8c8cfdbe",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873419483279949184"
},
{
"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"
}
}
[17:46:03.979] Scheduled build:
{
"id": "8707989421329825025",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"createdBy": "project:pigweed",
"createTime": "2025-07-29T17:46:03.548611236Z",
"updateTime": "2025-07-29T17:46:03.548611236Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "71336775a69224e1d2403e49bb5e26ab8c8cfdbe",
"ref": "refs/heads/main"
}
}
}
[17:46:03.979] Task URL: https://cr-buildbucket.appspot.com/build/8707989421329825025
[17:46:03.979] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:2:0) after 8m55s
[17:46:08.795] Received PubSub notification, asking Buildbucket for the build status
[17:46:08.821] Build status: SCHEDULED
[17:54:58.999] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:2:0)
[17:54:59.046] Build status: SCHEDULED
[17:54:59.046] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:4:0) after 6m47s
[18:01:46.087] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:4:0)
[18:01:46.152] Build status: SCHEDULED
[18:01:46.152] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:5:0) after 5m0s
[18:06:46.267] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:5:0)
[18:06:46.296] Build status: SCHEDULED
[18:06:46.296] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:6:0) after 2m51s
[18:09:37.483] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:6:0)
[18:09:37.514] Build status: SCHEDULED
[18:09:37.514] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:7:0) after 6m6s
[18:15:43.617] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:7:0)
[18:15:43.649] Build status: SCHEDULED
[18:15:43.649] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:8:0) after 9m13s
[18:24:56.715] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:8:0)
[18:24:56.746] Build status: SCHEDULED
[18:24:56.746] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:9:0) after 8m42s
[18:33:38.912] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:9:0)
[18:33:38.943] Build status: SCHEDULED
[18:33:38.943] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:10:0) after 2m0s
[18:35:39.054] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:10:0)
[18:35:39.083] Build status: SCHEDULED
[18:35:39.083] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:11:0) after 1m52s
[18:37:31.098] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:11:0)
[18:37:31.135] Build status: SCHEDULED
[18:37:31.135] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:12:0) after 8m31s
[18:46:02.161] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:12:0)
[18:46:02.179] Build status: SCHEDULED
[18:46:02.179] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:13:0) after 9m20s
[18:55:22.262] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:13:0)
[18:55:22.694] Build status: SCHEDULED
[18:55:22.694] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:14:0) after 2m43s
[18:58:05.751] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:14:0)
[18:58:05.768] Build status: SCHEDULED
[18:58:05.768] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:15:0) after 8m46s
[19:06:51.912] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:15:0)
[19:06:51.929] Build status: SCHEDULED
[19:06:51.929] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:16:0) after 4m9s
[19:11:00.952] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:16:0)
[19:11:00.973] Build status: SCHEDULED
[19:11:00.973] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:17:0) after 2m6s
[19:13:07.104] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:17:0)
[19:13:07.133] Build status: SCHEDULED
[19:13:07.133] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:18:0) after 5m26s
[19:18:33.152] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:18:0)
[19:18:33.182] Build status: SCHEDULED
[19:18:33.182] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:19:0) after 5m18s
[19:23:51.227] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:19:0)
[19:23:51.245] Build status: SCHEDULED
[19:23:51.245] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:20:0) after 4m5s
[19:27:56.254] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:20:0)
[19:27:56.272] Build status: SCHEDULED
[19:27:56.272] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:21:0) after 3m56s
[19:31:52.362] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:21:0)
[19:31:52.399] Build status: SCHEDULED
[19:31:52.399] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:22:0) after 3m26s
[19:35:18.531] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:22:0)
[19:35:18.570] Build status: SCHEDULED
[19:35:18.570] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:23:0) after 7m57s
[19:43:15.618] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:23:0)
[19:43:15.648] Build status: SCHEDULED
[19:43:15.648] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:24:0) after 7m28s
[19:50:43.793] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:24:0)
[19:50:43.810] Build status: SCHEDULED
[19:50:43.810] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:25:0) after 8m31s
[19:59:14.833] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:25:0)
[19:59:14.871] Build status: SCHEDULED
[19:59:14.871] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:26:0) after 2m25s
[20:01:40.048] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:26:0)
[20:01:40.077] Build status: SCHEDULED
[20:01:40.078] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:27:0) after 4m36s
[20:06:16.041] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:27:0)
[20:06:16.078] Build status: SCHEDULED
[20:06:16.078] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:28:0) after 9m52s
[20:16:08.131] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:28:0)
[20:16:08.162] Build status: SCHEDULED
[20:16:08.162] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:29:0) after 7m8s
[20:23:16.221] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:29:0)
[20:23:16.241] Build status: SCHEDULED
[20:23:16.241] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:30:0) after 8m26s
[20:31:42.220] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:30:0)
[20:31:42.238] Build status: SCHEDULED
[20:31:42.238] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:31:0) after 4m39s
[20:36:22.115] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:31:0)
[20:36:22.165] Build status: SCHEDULED
[20:36:22.165] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:32:0) after 5m25s
[20:41:47.284] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:32:0)
[20:41:47.314] Build status: SCHEDULED
[20:41:47.315] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:33:0) after 2m27s
[20:44:14.452] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:33:0)
[20:44:14.531] Build status: SCHEDULED
[20:44:14.531] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:34:0) after 5m4s
[20:49:18.524] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:34:0)
[20:49:18.610] Build status: SCHEDULED
[20:49:18.610] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:35:0) after 8m5s
[20:57:23.626] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:35:0)
[20:57:23.650] Build status: SCHEDULED
[20:57:23.650] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8873419483279949184:36:0) after 6m27s
[21:00:58.075] Received PubSub notification, asking Buildbucket for the build status
[21:00:58.096] Build status: STARTED
[21:01:11.647] Received PubSub notification, asking Buildbucket for the build status
[21:01:11.718] Build:
{
"id": "8707989421329825025",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"createdBy": "project:pigweed",
"createTime": "2025-07-29T17:46:03.548611236Z",
"startTime": "2025-07-29T21:00:57.855577995Z",
"endTime": "2025-07-29T21:01:11.426315426Z",
"updateTime": "2025-07-29T21:01:11.426315426Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "71336775a69224e1d2403e49bb5e26ab8c8cfdbe",
"ref": "refs/heads/main"
}
}
}
[21:01:11.718] Invocation finished in 3h15m9.413610962s with status FAILED