[20:39:37.535] New invocation is queued and will start shortly
[20:39:39.097] Starting the invocation (attempt 1)
[20:39:39.118] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/25adde6888ae4af0048aafd1934593454465d321"
[20:39:39.118] Popped gitiles commit info from properties and tags
[20:39:39.118] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:39:39.119] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:39:39.120] Buildbucket request:
{
"requestId": "8833364702974005632",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-python"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833364702974005632",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-bazel-python",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "d3e3c37d324ad69ac01c69f7ce802e75c600b455"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@d3e3c37d324ad69ac01c69f7ce802e75c600b455",
"title": "d3e3c37d324ad69ac01c69f7ce802e75c600b455",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/d3e3c37d324ad69ac01c69f7ce802e75c600b455"
},
{
"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": "8833364702974005632"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-bazel-python"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:39:39.883] Scheduled build:
{
"id": "8667934640499553073",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-python"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-14T20:39:39.275121595Z",
"updateTime": "2026-10-14T20:39:39.275121595Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "25adde6888ae4af0048aafd1934593454465d321",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:39:39.883] Task URL: https://cr-buildbucket.appspot.com/build/8667934640499553073
[20:39:39.883] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:2:0) after 1m43s
[20:39:40.808] Received PubSub notification, asking Buildbucket for the build status
[20:39:40.826] Build status: SCHEDULED
[20:41:22.944] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:2:0)
[20:41:22.989] Build status: SCHEDULED
[20:41:22.989] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:4:0) after 2m0s
[20:43:23.242] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:4:0)
[20:43:23.317] Build status: SCHEDULED
[20:43:23.317] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:5:0) after 7m37s
[20:51:00.425] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:5:0)
[20:51:00.446] Build status: SCHEDULED
[20:51:00.446] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:6:0) after 5m37s
[20:56:37.512] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:6:0)
[20:56:37.566] Build status: SCHEDULED
[20:56:37.566] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:7:0) after 4m51s
[21:01:28.605] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:7:0)
[21:01:28.631] Build status: SCHEDULED
[21:01:28.632] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:8:0) after 7m17s
[21:08:45.668] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:8:0)
[21:08:45.691] Build status: SCHEDULED
[21:08:45.691] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:9:0) after 2m44s
[21:11:29.710] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:9:0)
[21:11:29.731] Build status: SCHEDULED
[21:11:29.731] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:10:0) after 6m34s
[21:18:03.748] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:10:0)
[21:18:03.771] Build status: SCHEDULED
[21:18:03.771] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:11:0) after 7m29s
[21:25:32.838] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:11:0)
[21:25:32.993] Build status: SCHEDULED
[21:25:32.993] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:12:0) after 1m3s
[21:26:36.118] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:12:0)
[21:26:36.137] Build status: SCHEDULED
[21:26:36.137] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:13:0) after 7m53s
[21:34:29.202] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:13:0)
[21:34:29.220] Build status: SCHEDULED
[21:34:29.220] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:14:0) after 4m34s
[21:39:03.341] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:14:0)
[21:39:03.365] Build status: SCHEDULED
[21:39:03.365] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:15:0) after 2m54s
[21:41:57.431] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:15:0)
[21:41:57.458] Build status: SCHEDULED
[21:41:57.458] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:16:0) after 4m11s
[21:46:08.660] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:16:0)
[21:46:08.705] Build status: SCHEDULED
[21:46:08.705] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:17:0) after 6m21s
[21:52:29.922] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:17:0)
[21:52:29.941] Build status: SCHEDULED
[21:52:29.941] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:18:0) after 4m9s
[21:56:38.958] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:18:0)
[21:56:38.976] Build status: SCHEDULED
[21:56:38.976] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:19:0) after 4m45s
[22:01:24.101] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:19:0)
[22:01:24.131] Build status: SCHEDULED
[22:01:24.131] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:20:0) after 8m11s
[22:09:35.261] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:20:0)
[22:09:35.306] Build status: SCHEDULED
[22:09:35.306] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:21:0) after 7m56s
[22:17:31.355] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:21:0)
[22:17:31.383] Build status: SCHEDULED
[22:17:31.383] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:22:0) after 2m28s
[22:19:59.456] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:22:0)
[22:19:59.478] Build status: SCHEDULED
[22:19:59.478] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:23:0) after 7m11s
[22:27:10.494] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:23:0)
[22:27:10.515] Build status: SCHEDULED
[22:27:10.515] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:24:0) after 1m37s
[22:28:47.601] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:24:0)
[22:28:47.661] Build status: SCHEDULED
[22:28:47.661] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:25:0) after 4m55s
[22:33:42.680] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:25:0)
[22:33:42.701] Build status: SCHEDULED
[22:33:42.702] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:26:0) after 7m40s
[22:41:22.695] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:26:0)
[22:41:22.748] Build status: SCHEDULED
[22:41:22.748] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:27:0) after 2m53s
[22:44:15.814] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:27:0)
[22:44:15.836] Build status: SCHEDULED
[22:44:15.836] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:28:0) after 9m45s
[22:54:00.861] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:28:0)
[22:54:00.879] Build status: SCHEDULED
[22:54:00.879] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:29:0) after 5m10s
[22:59:10.998] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:29:0)
[22:59:11.021] Build status: SCHEDULED
[22:59:11.021] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:30:0) after 9m43s
[23:08:54.093] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:30:0)
[23:08:54.126] Build status: SCHEDULED
[23:08:54.127] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:31:0) after 2m11s
[23:11:05.147] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:31:0)
[23:11:05.273] Build status: SCHEDULED
[23:11:05.273] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:32:0) after 4m56s
[23:16:01.277] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:32:0)
[23:16:01.343] Build status: SCHEDULED
[23:16:01.344] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:33:0) after 7m35s
[23:23:36.401] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:33:0)
[23:23:36.442] Build status: SCHEDULED
[23:23:36.442] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:34:0) after 4m20s
[23:27:56.497] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:34:0)
[23:27:56.519] Build status: SCHEDULED
[23:27:56.519] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:35:0) after 6m31s
[23:34:27.539] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:35:0)
[23:34:27.608] Build status: SCHEDULED
[23:34:27.608] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:36:0) after 5m38s
[23:40:05.773] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:36:0)
[23:40:05.796] Build status: SCHEDULED
[23:40:05.796] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:37:0) after 8m34s
[23:48:39.783] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:37:0)
[23:48:39.812] Build status: SCHEDULED
[23:48:39.813] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:38:0) after 9m19s
[23:57:58.795] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:38:0)
[23:57:58.852] Build status: SCHEDULED
[23:57:58.852] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-python:8833364702974005632:39:0) after 7m57s
[00:02:55.177] Received PubSub notification, asking Buildbucket for the build status
[00:02:55.196] Build status: STARTED
[00:05:01.493] Received PubSub notification, asking Buildbucket for the build status
[00:05:01.536] Build:
{
"id": "8667934640499553073",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-python"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-14T20:39:39.275121595Z",
"startTime": "2026-10-15T00:02:54.958121988Z",
"endTime": "2026-10-15T00:05:01.055675184Z",
"updateTime": "2026-10-15T00:05:01.055675184Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "25adde6888ae4af0048aafd1934593454465d321",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:05:01.536] Invocation finished in 3h25m24.004093812s with status SUCCEEDED