[04:05:47.516] New invocation is queued and will start shortly
[04:05:48.826] Starting the invocation (attempt 1)
[04:05:48.853] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee"
[04:05:48.853] Popped gitiles commit info from properties and tags
[04:05:48.853] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:05:48.853] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:05:48.853] Buildbucket request:
{
"requestId": "8858160201413479136",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-gn-platform"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858160201413479136",
"job": "pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "5daee409009d26868e99ce2d78d58f68874e91b3"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@5daee409009d26868e99ce2d78d58f68874e91b3",
"title": "5daee409009d26868e99ce2d78d58f68874e91b3",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/5daee409009d26868e99ce2d78d58f68874e91b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "0fc191f72cf3a455c36917b94c006081518f3713"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@0fc191f72cf3a455c36917b94c006081518f3713",
"title": "0fc191f72cf3a455c36917b94c006081518f3713",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/0fc191f72cf3a455c36917b94c006081518f3713"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "099a6946741876f436b949b0fae9348d1cb8fae0"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@099a6946741876f436b949b0fae9348d1cb8fae0",
"title": "099a6946741876f436b949b0fae9348d1cb8fae0",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/099a6946741876f436b949b0fae9348d1cb8fae0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "3490c8bcfe79c2bceacd2e91b911063ec2ee3230"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@3490c8bcfe79c2bceacd2e91b911063ec2ee3230",
"title": "3490c8bcfe79c2bceacd2e91b911063ec2ee3230",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/3490c8bcfe79c2bceacd2e91b911063ec2ee3230"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "0fc1b1363de1b468ad2db6381d4ed7edd314a427"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@0fc1b1363de1b468ad2db6381d4ed7edd314a427",
"title": "0fc1b1363de1b468ad2db6381d4ed7edd314a427",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/0fc1b1363de1b468ad2db6381d4ed7edd314a427"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee",
"title": "b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858160201413479136"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:05:49.418] Scheduled build:
{
"id": "8692730139276891105",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-gn-platform"
},
"createdBy": "project:pigweed",
"createTime": "2026-01-14T04:05:48.929645075Z",
"updateTime": "2026-01-14T04:05:48.929645075Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee",
"ref": "refs/heads/main"
}
}
}
[04:05:49.418] Task URL: https://cr-buildbucket.appspot.com/build/8692730139276891105
[04:05:49.418] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:2:0) after 8m21s
[04:05:50.348] Received PubSub notification, asking Buildbucket for the build status
[04:05:50.363] Build status: SCHEDULED
[04:14:10.479] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:2:0)
[04:14:10.537] Build status: SCHEDULED
[04:14:10.538] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:4:0) after 6m58s
[04:21:08.590] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:4:0)
[04:21:08.618] Build status: SCHEDULED
[04:21:08.618] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:5:0) after 9m12s
[04:30:20.609] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:5:0)
[04:30:20.627] Build status: SCHEDULED
[04:30:20.627] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:6:0) after 2m42s
[04:33:02.638] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:6:0)
[04:33:02.668] Build status: SCHEDULED
[04:33:02.668] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:7:0) after 1m42s
[04:34:44.684] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:7:0)
[04:34:44.741] Build status: SCHEDULED
[04:34:44.741] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:8:0) after 7m1s
[04:41:45.774] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:8:0)
[04:41:45.792] Build status: SCHEDULED
[04:41:45.792] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:9:0) after 4m42s
[04:46:27.854] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:9:0)
[04:46:27.885] Build status: SCHEDULED
[04:46:27.886] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:10:0) after 5m36s
[04:52:03.996] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:10:0)
[04:52:04.013] Build status: SCHEDULED
[04:52:04.013] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:11:0) after 3m5s
[04:55:09.029] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:11:0)
[04:55:09.044] Build status: SCHEDULED
[04:55:09.044] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:12:0) after 5m3s
[05:00:12.108] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:12:0)
[05:00:12.130] Build status: SCHEDULED
[05:00:12.130] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:13:0) after 2m30s
[05:02:42.143] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:13:0)
[05:02:42.190] Build status: SCHEDULED
[05:02:42.190] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:14:0) after 4m8s
[05:06:50.219] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:14:0)
[05:06:50.238] Build status: SCHEDULED
[05:06:50.238] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:15:0) after 8m31s
[05:15:21.251] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:15:0)
[05:15:21.269] Build status: SCHEDULED
[05:15:21.269] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:16:0) after 1m1s
[05:16:22.324] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:16:0)
[05:16:22.340] Build status: SCHEDULED
[05:16:22.340] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:17:0) after 4m39s
[05:21:01.357] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:17:0)
[05:21:01.374] Build status: SCHEDULED
[05:21:01.374] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:18:0) after 8m32s
[05:29:33.399] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:18:0)
[05:29:33.468] Build status: SCHEDULED
[05:29:33.468] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:19:0) after 9m7s
[05:38:40.585] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:19:0)
[05:38:40.605] Build status: SCHEDULED
[05:38:40.605] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:20:0) after 7m44s
[05:46:24.620] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:20:0)
[05:46:24.789] Build status: SCHEDULED
[05:46:24.790] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:21:0) after 4m42s
[05:51:06.877] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:21:0)
[05:51:06.895] Build status: SCHEDULED
[05:51:06.895] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:22:0) after 3m10s
[05:54:17.188] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:22:0)
[05:54:17.201] Build status: SCHEDULED
[05:54:17.201] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:23:0) after 2m51s
[05:57:08.245] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:23:0)
[05:57:08.265] Build status: SCHEDULED
[05:57:08.265] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:24:0) after 1m1s
[05:58:09.372] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:24:0)
[05:58:09.393] Build status: SCHEDULED
[05:58:09.393] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:25:0) after 2m18s
[06:00:27.512] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:25:0)
[06:00:27.532] Build status: SCHEDULED
[06:00:27.532] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:26:0) after 4m0s
[06:04:27.596] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:26:0)
[06:04:27.620] Build status: SCHEDULED
[06:04:27.620] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:27:0) after 6m30s
[06:10:58.170] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:27:0)
[06:10:58.281] Build status: SCHEDULED
[06:10:58.281] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:28:0) after 7m46s
[06:18:44.297] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:28:0)
[06:18:44.312] Build status: SCHEDULED
[06:18:44.312] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:29:0) after 2m45s
[06:21:29.326] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:29:0)
[06:21:29.343] Build status: SCHEDULED
[06:21:29.343] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:30:0) after 4m47s
[06:26:16.360] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:30:0)
[06:26:16.404] Build status: SCHEDULED
[06:26:16.404] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:31:0) after 7m56s
[06:34:12.411] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:31:0)
[06:34:12.469] Build status: SCHEDULED
[06:34:12.469] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:32:0) after 3m46s
[06:37:58.494] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:32:0)
[06:37:58.555] Build status: SCHEDULED
[06:37:58.555] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:33:0) after 5m2s
[06:43:00.617] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:33:0)
[06:43:00.635] Build status: SCHEDULED
[06:43:00.635] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:34:0) after 2m18s
[06:45:18.932] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:34:0)
[06:45:18.951] Build status: SCHEDULED
[06:45:18.951] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:35:0) after 5m33s
[06:50:51.967] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:35:0)
[06:50:51.983] Build status: SCHEDULED
[06:50:51.984] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:36:0) after 5m1s
[06:55:52.984] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:36:0)
[06:55:53.099] Build status: SCHEDULED
[06:55:53.099] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:37:0) after 6m5s
[07:01:58.187] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:37:0)
[07:01:58.279] Build status: SCHEDULED
[07:01:58.279] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:38:0) after 2m38s
[07:04:36.293] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:38:0)
[07:04:36.311] Build status: SCHEDULED
[07:04:36.311] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:39:0) after 3m49s
[07:08:25.346] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:39:0)
[07:08:25.362] Build status: SCHEDULED
[07:08:25.362] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:40:0) after 2m59s
[07:08:40.487] Received PubSub notification, asking Buildbucket for the build status
[07:08:40.510] Build status: STARTED
[07:11:24.496] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:40:0)
[07:11:24.511] Build status: STARTED
[07:11:24.511] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:42:0) after 5m22s
[07:16:46.542] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:42:0)
[07:16:46.563] Build status: STARTED
[07:16:46.563] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-gn-platform:8858160201413479136:43:0) after 9m8s
[07:25:51.935] Received PubSub notification, asking Buildbucket for the build status
[07:25:51.956] Build:
{
"id": "8692730139276891105",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-gn-platform"
},
"createdBy": "project:pigweed",
"createTime": "2026-01-14T04:05:48.929645075Z",
"startTime": "2026-01-14T07:08:40.287836224Z",
"endTime": "2026-01-14T07:25:51.612761242Z",
"updateTime": "2026-01-14T07:25:51.612761242Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b199cd1ff78dbe9e8e24e5e8538b71929d5db5ee",
"ref": "refs/heads/main"
}
}
}
[07:25:51.956] Invocation finished in 3h20m4.448482721s with status SUCCEEDED