[00:48:02.402] New invocation is queued and will start shortly
[00:48:03.548] Starting the invocation (attempt 1)
[00:48:03.571] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/b128572f74456f46b2e306b7e3b2099fbad15c71"
[00:48:03.571] Popped gitiles commit info from properties and tags
[00:48:03.571] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:48:03.571] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:48:03.572] Buildbucket request:
{
"requestId": "8833167880154800368",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-sapphire"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833167880154800368",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "34b17a3f6588c548156b7c3bb316ccdbbb7c8137"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@34b17a3f6588c548156b7c3bb316ccdbbb7c8137",
"title": "34b17a3f6588c548156b7c3bb316ccdbbb7c8137",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/34b17a3f6588c548156b7c3bb316ccdbbb7c8137"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "a7be18d71c1066e82d6590afaa459b71e466750b"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@a7be18d71c1066e82d6590afaa459b71e466750b",
"title": "a7be18d71c1066e82d6590afaa459b71e466750b",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/a7be18d71c1066e82d6590afaa459b71e466750b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "d175adb4a4d112fd34bd3171b48b900da6e75f99"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@d175adb4a4d112fd34bd3171b48b900da6e75f99",
"title": "d175adb4a4d112fd34bd3171b48b900da6e75f99",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/d175adb4a4d112fd34bd3171b48b900da6e75f99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "96bd5f991aa21aec0dc6408e87ca137145a66015"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@96bd5f991aa21aec0dc6408e87ca137145a66015",
"title": "96bd5f991aa21aec0dc6408e87ca137145a66015",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/96bd5f991aa21aec0dc6408e87ca137145a66015"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "45375e60f69ffc9f002008607ba33843061a3079"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@45375e60f69ffc9f002008607ba33843061a3079",
"title": "45375e60f69ffc9f002008607ba33843061a3079",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/45375e60f69ffc9f002008607ba33843061a3079"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "b128572f74456f46b2e306b7e3b2099fbad15c71"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@b128572f74456f46b2e306b7e3b2099fbad15c71",
"title": "b128572f74456f46b2e306b7e3b2099fbad15c71",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/b128572f74456f46b2e306b7e3b2099fbad15c71"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b128572f74456f46b2e306b7e3b2099fbad15c71",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833167880154800368"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:48:03.964] Scheduled build:
{
"id": "8667737818206195265",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-sapphire"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-17T00:48:03.641313187Z",
"updateTime": "2026-10-17T00:48:03.641313187Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b128572f74456f46b2e306b7e3b2099fbad15c71",
"ref": "refs/heads/main"
}
}
}
[00:48:03.964] Task URL: https://cr-buildbucket.appspot.com/build/8667737818206195265
[00:48:03.964] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:2:0) after 5m10s
[00:48:04.997] Received PubSub notification, asking Buildbucket for the build status
[00:48:05.016] Build status: SCHEDULED
[00:53:13.991] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:2:0)
[00:53:14.020] Build status: SCHEDULED
[00:53:14.020] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:4:0) after 3m37s
[00:56:51.035] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:4:0)
[00:56:51.062] Build status: SCHEDULED
[00:56:51.062] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:5:0) after 8m27s
[01:05:18.075] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:5:0)
[01:05:18.291] Build status: SCHEDULED
[01:05:18.291] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:6:0) after 6m34s
[01:11:52.386] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:6:0)
[01:11:52.413] Build status: SCHEDULED
[01:11:52.414] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:7:0) after 9m15s
[01:21:07.472] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:7:0)
[01:21:07.498] Build status: SCHEDULED
[01:21:07.498] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:8:0) after 4m3s
[01:25:10.645] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:8:0)
[01:25:10.670] Build status: SCHEDULED
[01:25:10.670] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:9:0) after 8m33s
[01:33:43.834] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:9:0)
[01:33:43.852] Build status: SCHEDULED
[01:33:43.852] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:10:0) after 5m56s
[01:39:39.871] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:10:0)
[01:39:39.891] Build status: SCHEDULED
[01:39:39.891] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:11:0) after 2m18s
[01:41:57.904] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:11:0)
[01:41:57.962] Build status: SCHEDULED
[01:41:57.962] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:12:0) after 3m56s
[01:45:54.023] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:12:0)
[01:45:54.046] Build status: SCHEDULED
[01:45:54.046] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:13:0) after 3m52s
[01:49:46.059] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:13:0)
[01:49:46.077] Build status: SCHEDULED
[01:49:46.077] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:14:0) after 9m26s
[01:59:12.090] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:14:0)
[01:59:12.120] Build status: SCHEDULED
[01:59:12.120] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:15:0) after 6m46s
[02:05:58.243] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:15:0)
[02:05:58.268] Build status: SCHEDULED
[02:05:58.268] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:16:0) after 6m17s
[02:12:15.283] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:16:0)
[02:12:15.309] Build status: SCHEDULED
[02:12:15.309] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:17:0) after 5m27s
[02:17:42.424] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:17:0)
[02:17:42.441] Build status: SCHEDULED
[02:17:42.441] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:18:0) after 7m18s
[02:25:00.451] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:18:0)
[02:25:00.468] Build status: SCHEDULED
[02:25:00.468] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:19:0) after 4m35s
[02:29:35.482] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:19:0)
[02:29:35.501] Build status: SCHEDULED
[02:29:35.501] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:20:0) after 1m40s
[02:31:15.519] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:20:0)
[02:31:15.579] Build status: SCHEDULED
[02:31:15.579] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:21:0) after 8m38s
[02:39:53.596] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:21:0)
[02:39:53.615] Build status: SCHEDULED
[02:39:53.615] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:22:0) after 8m57s
[02:48:50.671] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:22:0)
[02:48:50.738] Build status: SCHEDULED
[02:48:50.738] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:23:0) after 1m33s
[02:50:23.759] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:23:0)
[02:50:23.778] Build status: SCHEDULED
[02:50:23.778] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:24:0) after 8m29s
[02:58:52.813] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:24:0)
[02:58:52.857] Build status: SCHEDULED
[02:58:52.857] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:25:0) after 2m13s
[03:01:05.886] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:25:0)
[03:01:06.078] Build status: SCHEDULED
[03:01:06.078] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:26:0) after 1m43s
[03:02:49.109] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:26:0)
[03:02:49.139] Build status: SCHEDULED
[03:02:49.139] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:27:0) after 6m25s
[03:09:14.162] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:27:0)
[03:09:14.181] Build status: SCHEDULED
[03:09:14.181] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:28:0) after 4m20s
[03:13:34.196] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:28:0)
[03:13:34.215] Build status: SCHEDULED
[03:13:34.215] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:29:0) after 4m33s
[03:18:07.227] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:29:0)
[03:18:07.246] Build status: SCHEDULED
[03:18:07.246] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:30:0) after 4m46s
[03:22:53.244] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:30:0)
[03:22:53.266] Build status: SCHEDULED
[03:22:53.271] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:31:0) after 8m24s
[03:31:17.385] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:31:0)
[03:31:17.405] Build status: SCHEDULED
[03:31:17.405] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:32:0) after 4m35s
[03:35:52.509] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:32:0)
[03:35:52.584] Build status: SCHEDULED
[03:35:52.584] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:33:0) after 1m46s
[03:37:38.627] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:33:0)
[03:37:38.659] Build status: SCHEDULED
[03:37:38.660] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:34:0) after 2m55s
[03:40:51.228] Received PubSub notification, asking Buildbucket for the build status
[03:40:51.296] Build status: STARTED
[03:41:02.400] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:34:0)
[03:41:02.428] Build status: STARTED
[03:41:02.428] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:36:0) after 5m43s
[03:46:45.499] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:36:0)
[03:46:45.521] Build status: STARTED
[03:46:45.521] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:37:0) after 8m7s
[03:54:52.580] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:37:0)
[03:54:52.595] Build status: STARTED
[03:54:52.595] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-sapphire:8833167880154800368:38:0) after 7m43s
[03:57:32.675] Received PubSub notification, asking Buildbucket for the build status
[03:57:32.697] Build:
{
"id": "8667737818206195265",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-sapphire"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-17T00:48:03.641313187Z",
"startTime": "2026-10-17T03:40:50.879885434Z",
"endTime": "2026-10-17T03:57:10.462935033Z",
"updateTime": "2026-10-17T03:57:10.462935033Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b128572f74456f46b2e306b7e3b2099fbad15c71",
"ref": "refs/heads/main"
}
}
}
[03:57:32.697] Invocation finished in 3h9m30.297919889s with status SUCCEEDED