[22:37:02.860] New invocation is queued and will start shortly
[22:37:03.904] Starting the invocation (attempt 1)
[22:37:03.936] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/1272c8a0a065f054d4aefa54e0861d95f365446a"
[22:37:03.936] Popped gitiles commit info from properties and tags
[22:37:03.936] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:37:03.936] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:37:03.937] Buildbucket request:
{
"requestId": "8871317444344544880",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-platform"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8871317444344544880",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-platform",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "7dc5bad7ae1fdcd3a94deb9348edfcc6112598e3"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@7dc5bad7ae1fdcd3a94deb9348edfcc6112598e3",
"title": "7dc5bad7ae1fdcd3a94deb9348edfcc6112598e3",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/7dc5bad7ae1fdcd3a94deb9348edfcc6112598e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "9ab3e0ccf8b98b48db8a57911843e95c84226706"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@9ab3e0ccf8b98b48db8a57911843e95c84226706",
"title": "9ab3e0ccf8b98b48db8a57911843e95c84226706",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/9ab3e0ccf8b98b48db8a57911843e95c84226706"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "c5cb259d1f2d114ef8718f18082fc481c5e0d9d4"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@c5cb259d1f2d114ef8718f18082fc481c5e0d9d4",
"title": "c5cb259d1f2d114ef8718f18082fc481c5e0d9d4",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/c5cb259d1f2d114ef8718f18082fc481c5e0d9d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "2345710d498f5854b9dc0794f37399a3d5ea9250"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@2345710d498f5854b9dc0794f37399a3d5ea9250",
"title": "2345710d498f5854b9dc0794f37399a3d5ea9250",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/2345710d498f5854b9dc0794f37399a3d5ea9250"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "266056a50275710831a0cc81a6af93e6fd08b848"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@266056a50275710831a0cc81a6af93e6fd08b848",
"title": "266056a50275710831a0cc81a6af93e6fd08b848",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/266056a50275710831a0cc81a6af93e6fd08b848"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "1f9ad055866e832a69f7157491f94f1e6c04c489"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@1f9ad055866e832a69f7157491f94f1e6c04c489",
"title": "1f9ad055866e832a69f7157491f94f1e6c04c489",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/1f9ad055866e832a69f7157491f94f1e6c04c489"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "8282c3383aa87400e67caa808179dd24d5cc470b"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@8282c3383aa87400e67caa808179dd24d5cc470b",
"title": "8282c3383aa87400e67caa808179dd24d5cc470b",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/8282c3383aa87400e67caa808179dd24d5cc470b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "a75fe5955113c7fa4724aeddd408569959f58dba"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@a75fe5955113c7fa4724aeddd408569959f58dba",
"title": "a75fe5955113c7fa4724aeddd408569959f58dba",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/a75fe5955113c7fa4724aeddd408569959f58dba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "1272c8a0a065f054d4aefa54e0861d95f365446a"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@1272c8a0a065f054d4aefa54e0861d95f365446a",
"title": "1272c8a0a065f054d4aefa54e0861d95f365446a",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/1272c8a0a065f054d4aefa54e0861d95f365446a"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "1272c8a0a065f054d4aefa54e0861d95f365446a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8871317444344544880"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-platform"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:37:04.382] Scheduled build:
{
"id": "8705887382479320993",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-platform"
},
"createdBy": "project:pigweed",
"createTime": "2025-08-21T22:37:04.012647379Z",
"updateTime": "2025-08-21T22:37:04.012647379Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "1272c8a0a065f054d4aefa54e0861d95f365446a",
"ref": "refs/heads/main"
}
}
}
[22:37:04.382] Task URL: https://cr-buildbucket.appspot.com/build/8705887382479320993
[22:37:04.382] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:2:0) after 6m15s
[22:37:05.422] Received PubSub notification, asking Buildbucket for the build status
[22:37:05.453] Build status: SCHEDULED
[22:43:19.429] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:2:0)
[22:43:19.467] Build status: SCHEDULED
[22:43:19.467] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:4:0) after 4m14s
[22:47:33.549] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:4:0)
[22:47:33.566] Build status: SCHEDULED
[22:47:33.566] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:5:0) after 7m1s
[22:54:34.617] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:5:0)
[22:54:34.635] Build status: SCHEDULED
[22:54:34.635] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:6:0) after 6m16s
[23:00:50.656] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:6:0)
[23:00:50.702] Build status: SCHEDULED
[23:00:50.702] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:7:0) after 4m45s
[23:05:35.768] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:7:0)
[23:05:35.830] Build status: SCHEDULED
[23:05:35.830] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:8:0) after 9m58s
[23:15:33.873] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:8:0)
[23:15:33.890] Build status: SCHEDULED
[23:15:33.890] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:9:0) after 4m30s
[23:20:03.907] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:9:0)
[23:20:03.952] Build status: SCHEDULED
[23:20:03.952] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:10:0) after 6m28s
[23:26:31.991] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:10:0)
[23:26:32.014] Build status: SCHEDULED
[23:26:32.014] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:11:0) after 1m17s
[23:27:49.169] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:11:0)
[23:27:49.210] Build status: SCHEDULED
[23:27:49.210] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:12:0) after 7m57s
[23:35:46.235] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:12:0)
[23:35:46.316] Build status: SCHEDULED
[23:35:46.316] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:13:0) after 9m17s
[23:45:03.383] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:13:0)
[23:45:03.433] Build status: SCHEDULED
[23:45:03.433] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:14:0) after 9m45s
[23:54:48.450] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:14:0)
[23:54:48.476] Build status: SCHEDULED
[23:54:48.476] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:15:0) after 6m48s
[00:01:36.538] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:15:0)
[00:01:36.571] Build status: SCHEDULED
[00:01:36.571] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:16:0) after 6m51s
[00:08:27.612] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:16:0)
[00:08:27.666] Build status: SCHEDULED
[00:08:27.666] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:17:0) after 5m45s
[00:14:12.683] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:17:0)
[00:14:12.794] Build status: SCHEDULED
[00:14:12.794] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:18:0) after 7m21s
[00:21:33.859] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:18:0)
[00:21:33.908] Build status: SCHEDULED
[00:21:33.909] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:19:0) after 9m1s
[00:30:34.930] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:19:0)
[00:30:34.955] Build status: SCHEDULED
[00:30:34.956] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:20:0) after 8m8s
[00:38:42.970] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:20:0)
[00:38:42.989] Build status: SCHEDULED
[00:38:42.989] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:21:0) after 6m25s
[00:45:08.025] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:21:0)
[00:45:08.389] Build status: SCHEDULED
[00:45:08.389] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:22:0) after 2m41s
[00:47:49.409] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:22:0)
[00:47:49.425] Build status: SCHEDULED
[00:47:49.426] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:23:0) after 8m53s
[00:56:42.441] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:23:0)
[00:56:42.469] Build status: SCHEDULED
[00:56:42.469] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:24:0) after 8m43s
[01:05:25.586] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:24:0)
[01:05:25.601] Build status: SCHEDULED
[01:05:25.601] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:25:0) after 2m43s
[01:08:08.624] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:25:0)
[01:08:08.653] Build status: SCHEDULED
[01:08:08.653] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:26:0) after 3m41s
[01:11:49.670] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:26:0)
[01:11:49.731] Build status: SCHEDULED
[01:11:49.731] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:27:0) after 4m25s
[01:16:14.897] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:27:0)
[01:16:14.917] Build status: SCHEDULED
[01:16:14.917] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:28:0) after 6m34s
[01:22:48.935] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:28:0)
[01:22:48.953] Build status: SCHEDULED
[01:22:48.953] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:29:0) after 1m22s
[01:24:11.022] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:29:0)
[01:24:11.040] Build status: SCHEDULED
[01:24:11.040] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:30:0) after 6m5s
[01:30:16.133] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:30:0)
[01:30:16.157] Build status: SCHEDULED
[01:30:16.157] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:31:0) after 4m16s
[01:34:32.170] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:31:0)
[01:34:32.193] Build status: SCHEDULED
[01:34:32.193] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:32:0) after 8m11s
[01:42:43.210] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:32:0)
[01:42:43.225] Build status: SCHEDULED
[01:42:43.225] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:33:0) after 7m49s
[01:50:32.432] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:33:0)
[01:50:32.449] Build status: SCHEDULED
[01:50:32.449] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:34:0) after 4m45s
[01:53:20.897] Received PubSub notification, asking Buildbucket for the build status
[01:53:20.921] Build status: STARTED
[01:55:17.475] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:34:0)
[01:55:17.520] Build status: STARTED
[01:55:17.520] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:36:0) after 8m48s
[02:04:05.536] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:36:0)
[02:04:05.559] Build status: STARTED
[02:04:05.559] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-platform:8871317444344544880:37:0) after 8m1s
[02:11:59.587] Received PubSub notification, asking Buildbucket for the build status
[02:11:59.741] Build:
{
"id": "8705887382479320993",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-platform"
},
"createdBy": "project:pigweed",
"createTime": "2025-08-21T22:37:04.012647379Z",
"startTime": "2025-08-22T01:53:20.050479910Z",
"endTime": "2025-08-22T02:11:59.084927055Z",
"updateTime": "2025-08-22T02:11:59.084927055Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "1272c8a0a065f054d4aefa54e0861d95f365446a",
"ref": "refs/heads/main"
}
}
}
[02:11:59.741] Invocation finished in 3h34m56.891238974s with status SUCCEEDED