[19:08:22.961] New invocation is queued and will start shortly
[19:08:24.222] Starting the invocation (attempt 1)
[19:08:24.248] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/1b63ce785368fa44d6103d381a9d1f96a3dd3ddf"
[19:08:24.248] Popped gitiles commit info from properties and tags
[19:08:24.248] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:08:24.249] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:08:24.249] Buildbucket request:
{
"requestId": "8833461040449380048",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833461040449380048",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-san",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "9a69ba062d4904f03550ef81c1df1ba00e27b399"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@9a69ba062d4904f03550ef81c1df1ba00e27b399",
"title": "9a69ba062d4904f03550ef81c1df1ba00e27b399",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/9a69ba062d4904f03550ef81c1df1ba00e27b399"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "3b96e849b07cd8f6bfadf616e025620da9773601"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@3b96e849b07cd8f6bfadf616e025620da9773601",
"title": "3b96e849b07cd8f6bfadf616e025620da9773601",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/3b96e849b07cd8f6bfadf616e025620da9773601"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "a81a480e9c6c1643d37c6ae9362cf742172c9a3a"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@a81a480e9c6c1643d37c6ae9362cf742172c9a3a",
"title": "a81a480e9c6c1643d37c6ae9362cf742172c9a3a",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/a81a480e9c6c1643d37c6ae9362cf742172c9a3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "ff5ab200cac446298320c62f9dade3bf53add1fb"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@ff5ab200cac446298320c62f9dade3bf53add1fb",
"title": "ff5ab200cac446298320c62f9dade3bf53add1fb",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/ff5ab200cac446298320c62f9dade3bf53add1fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "647720d7cfc092536fa1b5aaac0508f53a1a5506"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@647720d7cfc092536fa1b5aaac0508f53a1a5506",
"title": "647720d7cfc092536fa1b5aaac0508f53a1a5506",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/647720d7cfc092536fa1b5aaac0508f53a1a5506"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "1b63ce785368fa44d6103d381a9d1f96a3dd3ddf"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@1b63ce785368fa44d6103d381a9d1f96a3dd3ddf",
"title": "1b63ce785368fa44d6103d381a9d1f96a3dd3ddf",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/1b63ce785368fa44d6103d381a9d1f96a3dd3ddf"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "1b63ce785368fa44d6103d381a9d1f96a3dd3ddf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833461040449380048"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-san"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:08:24.691] Scheduled build:
{
"id": "8668030978372258033",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-13T19:08:24.320496492Z",
"updateTime": "2026-10-13T19:08:24.320496492Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "1b63ce785368fa44d6103d381a9d1f96a3dd3ddf",
"ref": "refs/heads/main"
}
}
}
[19:08:24.691] Task URL: https://cr-buildbucket.appspot.com/build/8668030978372258033
[19:08:24.692] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:2:0) after 1m43s
[19:08:25.103] Received PubSub notification, asking Buildbucket for the build status
[19:08:25.143] Build status: SCHEDULED
[19:10:07.794] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:2:0)
[19:10:07.817] Build status: SCHEDULED
[19:10:07.817] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:4:0) after 5m51s
[19:15:59.021] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:4:0)
[19:15:59.063] Build status: SCHEDULED
[19:15:59.063] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:5:0) after 3m36s
[19:19:35.085] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:5:0)
[19:19:35.109] Build status: SCHEDULED
[19:19:35.109] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:6:0) after 2m51s
[19:22:26.137] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:6:0)
[19:22:26.153] Build status: SCHEDULED
[19:22:26.153] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:7:0) after 2m54s
[19:25:20.209] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:7:0)
[19:25:20.259] Build status: SCHEDULED
[19:25:20.259] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:8:0) after 6m59s
[19:32:19.369] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:8:0)
[19:32:19.401] Build status: SCHEDULED
[19:32:19.401] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:9:0) after 5m12s
[19:37:31.417] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:9:0)
[19:37:31.439] Build status: SCHEDULED
[19:37:31.440] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:10:0) after 6m15s
[19:43:46.606] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:10:0)
[19:43:46.632] Build status: SCHEDULED
[19:43:46.632] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:11:0) after 5m6s
[19:48:52.764] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:11:0)
[19:48:52.789] Build status: SCHEDULED
[19:48:52.789] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:12:0) after 3m38s
[19:52:30.969] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:12:0)
[19:52:30.990] Build status: SCHEDULED
[19:52:30.990] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:13:0) after 9m10s
[20:01:41.332] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:13:0)
[20:01:41.368] Build status: SCHEDULED
[20:01:41.370] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:14:0) after 1m2s
[20:02:43.474] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:14:0)
[20:02:43.496] Build status: SCHEDULED
[20:02:43.496] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:15:0) after 2m10s
[20:04:53.489] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:15:0)
[20:04:53.583] Build status: SCHEDULED
[20:04:53.583] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:16:0) after 7m25s
[20:12:18.627] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:16:0)
[20:12:18.648] Build status: SCHEDULED
[20:12:18.648] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:17:0) after 7m58s
[20:20:16.669] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:17:0)
[20:20:16.691] Build status: SCHEDULED
[20:20:16.691] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:18:0) after 2m21s
[20:22:37.736] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:18:0)
[20:22:37.755] Build status: SCHEDULED
[20:22:37.755] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:19:0) after 3m57s
[20:26:34.956] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:19:0)
[20:26:35.005] Build status: SCHEDULED
[20:26:35.005] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:20:0) after 8m25s
[20:35:00.118] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:20:0)
[20:35:00.138] Build status: SCHEDULED
[20:35:00.138] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:21:0) after 1m16s
[20:36:16.156] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:21:0)
[20:36:16.276] Build status: SCHEDULED
[20:36:16.276] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:22:0) after 5m45s
[20:42:01.293] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:22:0)
[20:42:01.313] Build status: SCHEDULED
[20:42:01.313] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:23:0) after 1m32s
[20:43:33.389] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:23:0)
[20:43:33.410] Build status: SCHEDULED
[20:43:33.410] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:24:0) after 9m40s
[20:53:13.507] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:24:0)
[20:53:13.591] Build status: SCHEDULED
[20:53:13.591] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:25:0) after 8m42s
[21:01:55.686] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:25:0)
[21:01:55.708] Build status: SCHEDULED
[21:01:55.708] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:26:0) after 9m27s
[21:11:22.913] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:26:0)
[21:11:22.946] Build status: SCHEDULED
[21:11:22.946] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:27:0) after 3m4s
[21:14:26.992] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:27:0)
[21:14:27.016] Build status: SCHEDULED
[21:14:27.016] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:28:0) after 7m7s
[21:21:34.004] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:28:0)
[21:21:34.030] Build status: SCHEDULED
[21:21:34.030] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:29:0) after 9m12s
[21:23:20.823] Received PubSub notification, asking Buildbucket for the build status
[21:23:20.845] Build status: STARTED
[21:30:46.124] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:29:0)
[21:30:46.153] Build status: STARTED
[21:30:46.153] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8833461040449380048:31:0) after 9m54s
[21:38:42.476] Received PubSub notification, asking Buildbucket for the build status
[21:38:42.501] Build:
{
"id": "8668030978372258033",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-13T19:08:24.320496492Z",
"startTime": "2026-10-13T21:23:20.648926625Z",
"endTime": "2026-10-13T21:38:30.396350270Z",
"updateTime": "2026-10-13T21:38:30.396350270Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "1b63ce785368fa44d6103d381a9d1f96a3dd3ddf",
"ref": "refs/heads/main"
}
}
}
[21:38:42.501] Invocation finished in 2h30m19.544584181s with status SUCCEEDED