[19:30:50.304] New invocation is queued and will start shortly
[19:30:51.392] Starting the invocation (attempt 1)
[19:30:51.422] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/f0a25428b8eff2b4756209c2233d59a3502d6e9c"
[19:30:51.422] Popped gitiles commit info from properties and tags
[19:30:51.422] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:51.422] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:51.423] Buildbucket request:
{
"requestId": "8875224829169982400",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-vscode"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875224829169982400",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-vscode",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "147534487a46dd9576d4641d945276d7f8c69134"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@147534487a46dd9576d4641d945276d7f8c69134",
"title": "147534487a46dd9576d4641d945276d7f8c69134",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/147534487a46dd9576d4641d945276d7f8c69134"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "989be4effd97fb363152feacaf2f87574d9d15fc"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@989be4effd97fb363152feacaf2f87574d9d15fc",
"title": "989be4effd97fb363152feacaf2f87574d9d15fc",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/989be4effd97fb363152feacaf2f87574d9d15fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "afe3e32392ac5ea4c496438528b1c48c75702f58"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@afe3e32392ac5ea4c496438528b1c48c75702f58",
"title": "afe3e32392ac5ea4c496438528b1c48c75702f58",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/afe3e32392ac5ea4c496438528b1c48c75702f58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "f0a25428b8eff2b4756209c2233d59a3502d6e9c"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@f0a25428b8eff2b4756209c2233d59a3502d6e9c",
"title": "f0a25428b8eff2b4756209c2233d59a3502d6e9c",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/f0a25428b8eff2b4756209c2233d59a3502d6e9c"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "f0a25428b8eff2b4756209c2233d59a3502d6e9c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875224829169982400"
},
{
"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"
}
}
[19:30:51.833] Scheduled build:
{
"id": "8709794767266459601",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-vscode"
},
"createdBy": "project:pigweed",
"createTime": "2025-07-09T19:30:51.496574565Z",
"updateTime": "2025-07-09T19:30:51.496574565Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "f0a25428b8eff2b4756209c2233d59a3502d6e9c",
"ref": "refs/heads/main"
}
}
}
[19:30:51.833] Task URL: https://cr-buildbucket.appspot.com/build/8709794767266459601
[19:30:51.833] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:2:0) after 2m50s
[19:30:52.144] Received PubSub notification, asking Buildbucket for the build status
[19:30:52.172] Build status: SCHEDULED
[19:33:41.849] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:2:0)
[19:33:41.955] Build status: SCHEDULED
[19:33:41.955] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:4:0) after 6m19s
[19:40:00.980] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:4:0)
[19:40:00.998] Build status: SCHEDULED
[19:40:00.998] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:5:0) after 9m42s
[19:49:43.025] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:5:0)
[19:49:43.053] Build status: SCHEDULED
[19:49:43.053] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:6:0) after 1m52s
[19:51:35.099] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:6:0)
[19:51:35.378] Build status: SCHEDULED
[19:51:35.378] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:7:0) after 1m52s
[19:53:27.396] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:7:0)
[19:53:27.426] Build status: SCHEDULED
[19:53:27.426] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:8:0) after 6m51s
[20:00:18.467] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:8:0)
[20:00:18.503] Build status: SCHEDULED
[20:00:18.503] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:9:0) after 4m57s
[20:05:15.527] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:9:0)
[20:05:15.541] Build status: SCHEDULED
[20:05:15.541] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:10:0) after 9m45s
[20:15:00.671] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:10:0)
[20:15:00.698] Build status: SCHEDULED
[20:15:00.698] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:11:0) after 5m27s
[20:20:27.765] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:11:0)
[20:20:27.787] Build status: SCHEDULED
[20:20:27.787] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:12:0) after 4m25s
[20:24:52.779] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:12:0)
[20:24:52.858] Build status: SCHEDULED
[20:24:52.858] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:13:0) after 3m4s
[20:27:56.918] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:13:0)
[20:27:56.941] Build status: SCHEDULED
[20:27:56.941] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:14:0) after 9m44s
[20:37:41.023] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:14:0)
[20:37:41.047] Build status: SCHEDULED
[20:37:41.047] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:15:0) after 3m22s
[20:41:03.098] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:15:0)
[20:41:03.170] Build status: SCHEDULED
[20:41:03.170] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:16:0) after 5m35s
[20:46:38.353] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:16:0)
[20:46:38.373] Build status: SCHEDULED
[20:46:38.373] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:17:0) after 2m32s
[20:49:10.519] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:17:0)
[20:49:10.713] Build status: SCHEDULED
[20:49:10.713] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:18:0) after 9m1s
[20:58:11.877] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:18:0)
[20:58:11.899] Build status: SCHEDULED
[20:58:11.899] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:19:0) after 3m31s
[21:01:42.964] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:19:0)
[21:01:43.071] Build status: SCHEDULED
[21:01:43.071] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:20:0) after 7m42s
[21:09:25.206] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:20:0)
[21:09:25.238] Build status: SCHEDULED
[21:09:25.238] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:21:0) after 4m31s
[21:13:56.300] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:21:0)
[21:13:56.326] Build status: SCHEDULED
[21:13:56.326] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:22:0) after 9m48s
[21:23:44.355] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:22:0)
[21:23:44.376] Build status: SCHEDULED
[21:23:44.376] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:23:0) after 5m45s
[21:29:29.396] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:23:0)
[21:29:29.422] Build status: SCHEDULED
[21:29:29.422] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:24:0) after 3m33s
[21:33:02.507] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:24:0)
[21:33:02.545] Build status: SCHEDULED
[21:33:02.545] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:25:0) after 5m40s
[21:38:42.684] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:25:0)
[21:38:42.742] Build status: SCHEDULED
[21:38:42.742] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:26:0) after 5m15s
[21:43:57.910] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:26:0)
[21:43:57.928] Build status: SCHEDULED
[21:43:57.928] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:27:0) after 9m23s
[21:53:21.057] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:27:0)
[21:53:21.097] Build status: SCHEDULED
[21:53:21.097] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:28:0) after 9m9s
[22:02:30.167] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:28:0)
[22:02:30.727] Build status: SCHEDULED
[22:02:30.727] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:29:0) after 6m36s
[22:09:06.752] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:29:0)
[22:09:06.777] Build status: SCHEDULED
[22:09:06.777] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:30:0) after 8m12s
[22:17:18.918] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:30:0)
[22:17:18.952] Build status: SCHEDULED
[22:17:18.952] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:31:0) after 1m32s
[22:18:50.973] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:31:0)
[22:18:50.994] Build status: SCHEDULED
[22:18:50.994] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:32:0) after 9m8s
[22:27:59.018] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:32:0)
[22:27:59.038] Build status: SCHEDULED
[22:27:59.038] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:33:0) after 3m41s
[22:31:40.126] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:33:0)
[22:31:40.147] Build status: SCHEDULED
[22:31:40.147] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:34:0) after 7m44s
[22:39:24.176] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:34:0)
[22:39:24.195] Build status: SCHEDULED
[22:39:24.195] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:35:0) after 7m6s
[22:46:30.197] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:35:0)
[22:46:30.220] Build status: SCHEDULED
[22:46:30.220] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:36:0) after 5m48s
[22:52:18.349] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:36:0)
[22:52:18.440] Build status: SCHEDULED
[22:52:18.440] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:37:0) after 6m31s
[22:58:49.565] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:37:0)
[22:58:49.589] Build status: SCHEDULED
[22:58:49.589] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:38:0) after 6m11s
[23:05:00.754] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:38:0)
[23:05:00.776] Build status: SCHEDULED
[23:05:00.776] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:39:0) after 3m22s
[23:08:22.807] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:39:0)
[23:08:22.832] Build status: SCHEDULED
[23:08:22.832] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-vscode:8875224829169982400:40:0) after 6m50s
[23:10:21.152] Received PubSub notification, asking Buildbucket for the build status
[23:10:21.174] Build status: STARTED
[23:14:17.123] Received PubSub notification, asking Buildbucket for the build status
[23:14:17.224] Build:
{
"id": "8709794767266459601",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-vscode"
},
"createdBy": "project:pigweed",
"createTime": "2025-07-09T19:30:51.496574565Z",
"startTime": "2025-07-09T23:10:20.557064564Z",
"endTime": "2025-07-09T23:14:15.914273823Z",
"updateTime": "2025-07-09T23:14:15.914273823Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "f0a25428b8eff2b4756209c2233d59a3502d6e9c",
"ref": "refs/heads/main"
}
}
}
[23:14:17.224] Invocation finished in 3h43m26.927628418s with status FAILED