[21:01:31.141] New invocation is queued and will start shortly
[21:01:32.398] Starting the invocation (attempt 1)
[21:01:32.426] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/25adde6888ae4af0048aafd1934593454465d321"
[21:01:32.426] Popped gitiles commit info from properties and tags
[21:01:32.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:01:32.426] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:01:32.427] Buildbucket request:
{
"requestId": "8833363325559122784",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-vscode"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833363325559122784",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-vscode",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "352fad0644b88a4f30915bc64cdf6d602d003e58"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@352fad0644b88a4f30915bc64cdf6d602d003e58",
"title": "352fad0644b88a4f30915bc64cdf6d602d003e58",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/352fad0644b88a4f30915bc64cdf6d602d003e58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "e2be7cf9b29a438cc8a7ada6bab6309956a47011"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@e2be7cf9b29a438cc8a7ada6bab6309956a47011",
"title": "e2be7cf9b29a438cc8a7ada6bab6309956a47011",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/e2be7cf9b29a438cc8a7ada6bab6309956a47011"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "d01b902f2313780abc6257e375861b0c11a197f9"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@d01b902f2313780abc6257e375861b0c11a197f9",
"title": "d01b902f2313780abc6257e375861b0c11a197f9",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/d01b902f2313780abc6257e375861b0c11a197f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "150c95b6aadd037dd30d35d2202fc4cbb8cf3fd1"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@150c95b6aadd037dd30d35d2202fc4cbb8cf3fd1",
"title": "150c95b6aadd037dd30d35d2202fc4cbb8cf3fd1",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/150c95b6aadd037dd30d35d2202fc4cbb8cf3fd1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "d4a4e5b576f23773f18d2b62cfa10dd4630dae27"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@d4a4e5b576f23773f18d2b62cfa10dd4630dae27",
"title": "d4a4e5b576f23773f18d2b62cfa10dd4630dae27",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/d4a4e5b576f23773f18d2b62cfa10dd4630dae27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "f9427c111825ba93f0459d30b43245bad773364a"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@f9427c111825ba93f0459d30b43245bad773364a",
"title": "f9427c111825ba93f0459d30b43245bad773364a",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/f9427c111825ba93f0459d30b43245bad773364a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "25adde6888ae4af0048aafd1934593454465d321"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@25adde6888ae4af0048aafd1934593454465d321",
"title": "25adde6888ae4af0048aafd1934593454465d321",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/25adde6888ae4af0048aafd1934593454465d321"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "25adde6888ae4af0048aafd1934593454465d321",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833363325559122784"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-vscode"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:01:32.878] Scheduled build:
{
"id": "8667933263469890145",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-vscode"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-14T21:01:32.513000365Z",
"updateTime": "2026-10-14T21:01:32.513000365Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "25adde6888ae4af0048aafd1934593454465d321",
"ref": "refs/heads/main"
}
}
}
[21:01:32.878] Task URL: https://cr-buildbucket.appspot.com/build/8667933263469890145
[21:01:32.878] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:2:0) after 6m48s
[21:01:33.823] Received PubSub notification, asking Buildbucket for the build status
[21:01:33.848] Build status: SCHEDULED
[21:08:20.877] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:2:0)
[21:08:20.922] Build status: SCHEDULED
[21:08:20.922] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:4:0) after 1m18s
[21:09:38.977] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:4:0)
[21:09:39.010] Build status: SCHEDULED
[21:09:39.010] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:5:0) after 8m39s
[21:18:18.028] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:5:0)
[21:18:18.063] Build status: SCHEDULED
[21:18:18.063] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:6:0) after 2m48s
[21:21:06.130] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:6:0)
[21:21:06.158] Build status: SCHEDULED
[21:21:06.158] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:7:0) after 3m23s
[21:24:29.173] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:7:0)
[21:24:29.302] Build status: SCHEDULED
[21:24:29.302] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:8:0) after 7m13s
[21:31:42.527] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:8:0)
[21:31:42.622] Build status: SCHEDULED
[21:31:42.622] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:9:0) after 8m12s
[21:39:54.706] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:9:0)
[21:39:54.723] Build status: SCHEDULED
[21:39:54.723] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:10:0) after 7m34s
[21:47:28.744] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:10:0)
[21:47:28.765] Build status: SCHEDULED
[21:47:28.765] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:11:0) after 6m44s
[21:54:12.783] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:11:0)
[21:54:12.805] Build status: SCHEDULED
[21:54:12.805] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:12:0) after 8m20s
[22:02:32.838] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:12:0)
[22:02:32.866] Build status: SCHEDULED
[22:02:32.866] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:13:0) after 7m49s
[22:10:21.934] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:13:0)
[22:10:21.977] Build status: SCHEDULED
[22:10:21.977] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:14:0) after 2m12s
[22:12:33.998] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:14:0)
[22:12:34.027] Build status: SCHEDULED
[22:12:34.027] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:15:0) after 1m41s
[22:14:15.042] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:15:0)
[22:14:15.064] Build status: SCHEDULED
[22:14:15.064] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:16:0) after 1m31s
[22:15:46.235] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:16:0)
[22:15:46.254] Build status: SCHEDULED
[22:15:46.254] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:17:0) after 3m0s
[22:18:46.520] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:17:0)
[22:18:46.539] Build status: SCHEDULED
[22:18:46.539] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:18:0) after 2m5s
[22:20:51.556] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:18:0)
[22:20:51.580] Build status: SCHEDULED
[22:20:51.580] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:19:0) after 2m18s
[22:23:09.981] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:19:0)
[22:23:10.052] Build status: SCHEDULED
[22:23:10.052] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:20:0) after 8m50s
[22:32:00.071] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:20:0)
[22:32:00.092] Build status: SCHEDULED
[22:32:00.092] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:21:0) after 2m57s
[22:34:57.171] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:21:0)
[22:34:57.196] Build status: SCHEDULED
[22:34:57.196] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:22:0) after 4m44s
[22:39:41.177] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:22:0)
[22:39:41.207] Build status: SCHEDULED
[22:39:41.207] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:23:0) after 1m34s
[22:41:15.333] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:23:0)
[22:41:15.377] Build status: SCHEDULED
[22:41:15.377] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:24:0) after 5m50s
[22:47:05.399] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:24:0)
[22:47:05.420] Build status: SCHEDULED
[22:47:05.422] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:25:0) after 2m17s
[22:49:22.454] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:25:0)
[22:49:22.505] Build status: SCHEDULED
[22:49:22.505] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:26:0) after 6m12s
[22:55:34.532] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:26:0)
[22:55:34.557] Build status: SCHEDULED
[22:55:34.557] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:27:0) after 1m30s
[22:57:04.790] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:27:0)
[22:57:04.811] Build status: SCHEDULED
[22:57:04.811] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:28:0) after 3m16s
[23:00:20.861] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:28:0)
[23:00:20.882] Build status: SCHEDULED
[23:00:20.882] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:29:0) after 9m8s
[23:09:29.034] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:29:0)
[23:09:29.060] Build status: SCHEDULED
[23:09:29.060] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:30:0) after 9m34s
[23:19:03.164] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:30:0)
[23:19:03.185] Build status: SCHEDULED
[23:19:03.185] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:31:0) after 6m53s
[23:25:56.371] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:31:0)
[23:25:56.391] Build status: SCHEDULED
[23:25:56.391] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:32:0) after 7m25s
[23:33:21.439] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:32:0)
[23:33:21.472] Build status: SCHEDULED
[23:33:21.472] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:33:0) after 4m44s
[23:38:05.520] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:33:0)
[23:38:05.557] Build status: SCHEDULED
[23:38:05.557] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:34:0) after 6m20s
[23:44:25.608] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:34:0)
[23:44:25.631] Build status: SCHEDULED
[23:44:25.631] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:35:0) after 7m48s
[23:52:13.654] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:35:0)
[23:52:13.685] Build status: SCHEDULED
[23:52:13.685] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:36:0) after 6m28s
[23:58:41.734] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:36:0)
[23:58:41.769] Build status: SCHEDULED
[23:58:41.769] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:37:0) after 3m26s
[00:02:07.839] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:37:0)
[00:02:07.860] Build status: SCHEDULED
[00:02:07.860] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:38:0) after 4m22s
[00:06:29.952] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:38:0)
[00:06:29.973] Build status: SCHEDULED
[00:06:29.973] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:39:0) after 3m3s
[00:09:32.951] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:39:0)
[00:09:32.973] Build status: SCHEDULED
[00:09:32.973] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:40:0) after 2m34s
[00:12:07.055] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:40:0)
[00:12:07.096] Build status: SCHEDULED
[00:12:07.099] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:41:0) after 8m15s
[00:20:22.144] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:41:0)
[00:20:22.168] Build status: SCHEDULED
[00:20:22.168] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:42:0) after 6m0s
[00:26:22.388] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:42:0)
[00:26:22.412] Build status: SCHEDULED
[00:26:22.412] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:43:0) after 6m59s
[00:30:37.548] Received PubSub notification, asking Buildbucket for the build status
[00:30:37.567] Build status: STARTED
[00:33:21.426] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:43:0)
[00:33:21.498] Build status: STARTED
[00:33:21.498] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8833363325559122784:45:0) after 9m4s
[00:34:56.866] Received PubSub notification, asking Buildbucket for the build status
[00:34:56.887] Build:
{
"id": "8667933263469890145",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-vscode"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-14T21:01:32.513000365Z",
"startTime": "2026-10-15T00:30:36.565013720Z",
"endTime": "2026-10-15T00:34:56.541043521Z",
"updateTime": "2026-10-15T00:34:56.541043521Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "25adde6888ae4af0048aafd1934593454465d321",
"ref": "refs/heads/main"
}
}
}
[00:34:56.887] Invocation finished in 3h33m25.749642053s with status FAILED