[02:30:16.910] New invocation is queued and will start shortly
[02:30:17.973] Starting the invocation (attempt 1)
[02:30:17.995] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/gonk/+/b566215d60249c8b54bcea4c401e358c7d855195"
[02:30:17.996] Popped gitiles commit info from properties and tags
[02:30:17.996] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:30:17.996] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:30:17.996] Buildbucket request:
{
"requestId": "8834610999122544352",
"builder": {
"project": "pigweed",
"bucket": "gonk.dev.ci",
"builder": "gonk-deps"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8834610999122544352",
"job": "pigweed/gonk.dev.ci-gonk-deps",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/gonk",
"revision": "b566215d60249c8b54bcea4c401e358c7d855195"
},
"id": "https://pigweed.googlesource.com/gonk/+/refs/heads/main@b566215d60249c8b54bcea4c401e358c7d855195",
"title": "b566215d60249c8b54bcea4c401e358c7d855195",
"url": "https://pigweed.googlesource.com/gonk/+/b566215d60249c8b54bcea4c401e358c7d855195"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "gonk",
"id": "b566215d60249c8b54bcea4c401e358c7d855195",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8834610999122544352"
},
{
"key": "scheduler_job_id",
"value": "pigweed/gonk.dev.ci-gonk-deps"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:30:18.421] Scheduled build:
{
"id": "8669180937267034193",
"builder": {
"project": "pigweed",
"bucket": "gonk.dev.ci",
"builder": "gonk-deps"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-01T02:30:18.057273140Z",
"updateTime": "2026-10-01T02:30:18.057273140Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "gonk",
"id": "b566215d60249c8b54bcea4c401e358c7d855195",
"ref": "refs/heads/main"
}
}
}
[02:30:18.421] Task URL: https://cr-buildbucket.appspot.com/build/8669180937267034193
[02:30:18.421] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:2:0) after 1m19s
[02:30:19.319] Received PubSub notification, asking Buildbucket for the build status
[02:30:19.367] Build status: SCHEDULED
[02:31:37.603] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:2:0)
[02:31:37.717] Build status: SCHEDULED
[02:31:37.717] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:4:0) after 5m14s
[02:36:51.832] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:4:0)
[02:36:51.899] Build status: SCHEDULED
[02:36:51.899] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:5:0) after 5m40s
[02:42:31.885] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:5:0)
[02:42:31.909] Build status: SCHEDULED
[02:42:31.909] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:6:0) after 8m7s
[02:50:38.924] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:6:0)
[02:50:38.947] Build status: SCHEDULED
[02:50:38.947] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:7:0) after 7m52s
[02:58:30.998] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:7:0)
[02:58:31.032] Build status: SCHEDULED
[02:58:31.032] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:8:0) after 8m12s
[03:06:43.048] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:8:0)
[03:06:43.128] Build status: SCHEDULED
[03:06:43.129] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:9:0) after 1m53s
[03:08:36.146] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:9:0)
[03:08:36.213] Build status: SCHEDULED
[03:08:36.213] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:10:0) after 3m53s
[03:12:29.254] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:10:0)
[03:12:29.309] Build status: SCHEDULED
[03:12:29.309] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:11:0) after 3m42s
[03:16:11.508] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:11:0)
[03:16:11.543] Build status: SCHEDULED
[03:16:11.543] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:12:0) after 5m29s
[03:21:40.659] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:12:0)
[03:21:40.748] Build status: SCHEDULED
[03:21:40.748] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:13:0) after 1m25s
[03:23:05.857] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:13:0)
[03:23:05.875] Build status: SCHEDULED
[03:23:05.875] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:14:0) after 8m13s
[03:31:18.888] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:14:0)
[03:31:18.913] Build status: SCHEDULED
[03:31:18.913] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:15:0) after 5m47s
[03:37:05.929] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:15:0)
[03:37:05.955] Build status: SCHEDULED
[03:37:05.955] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:16:0) after 4m1s
[03:41:06.987] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:16:0)
[03:41:07.214] Build status: SCHEDULED
[03:41:07.214] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:17:0) after 5m18s
[03:46:25.229] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:17:0)
[03:46:25.257] Build status: SCHEDULED
[03:46:25.257] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:18:0) after 5m32s
[03:51:57.367] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:18:0)
[03:51:57.406] Build status: SCHEDULED
[03:51:57.406] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:19:0) after 4m15s
[03:56:12.390] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:19:0)
[03:56:12.415] Build status: SCHEDULED
[03:56:12.415] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:20:0) after 4m57s
[04:01:09.431] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:20:0)
[04:01:09.456] Build status: SCHEDULED
[04:01:09.456] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:21:0) after 8m35s
[04:09:44.682] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:21:0)
[04:09:44.718] Build status: SCHEDULED
[04:09:44.718] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:22:0) after 4m44s
[04:14:28.851] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:22:0)
[04:14:28.873] Build status: SCHEDULED
[04:14:28.874] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:23:0) after 7m25s
[04:21:54.038] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:23:0)
[04:21:54.060] Build status: SCHEDULED
[04:21:54.060] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:24:0) after 2m47s
[04:24:41.156] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:24:0)
[04:24:41.177] Build status: SCHEDULED
[04:24:41.178] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:25:0) after 6m55s
[04:31:36.369] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:25:0)
[04:31:36.392] Build status: SCHEDULED
[04:31:36.392] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:26:0) after 4m14s
[04:35:50.383] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:26:0)
[04:35:50.972] Build status: SCHEDULED
[04:35:50.972] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:27:0) after 9m20s
[04:45:11.120] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:27:0)
[04:45:11.169] Build status: SCHEDULED
[04:45:11.169] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:28:0) after 8m41s
[04:53:52.186] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:28:0)
[04:53:52.214] Build status: SCHEDULED
[04:53:52.214] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:29:0) after 5m52s
[04:59:44.328] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:29:0)
[04:59:44.347] Build status: SCHEDULED
[04:59:44.347] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:30:0) after 3m59s
[05:03:43.461] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:30:0)
[05:03:43.487] Build status: SCHEDULED
[05:03:43.487] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:31:0) after 1m17s
[05:05:00.542] Handling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:31:0)
[05:05:00.572] Build status: SCHEDULED
[05:05:00.572] Scheduling timer "check-buildbucket-build-status" (pigweed/gonk.dev.ci-gonk-deps:8834610999122544352:32:0) after 8m11s
[05:06:40.414] Received PubSub notification, asking Buildbucket for the build status
[05:06:40.436] Build status: STARTED
[05:09:19.052] Received PubSub notification, asking Buildbucket for the build status
[05:09:19.074] Build:
{
"id": "8669180937267034193",
"builder": {
"project": "pigweed",
"bucket": "gonk.dev.ci",
"builder": "gonk-deps"
},
"createdBy": "project:pigweed",
"createTime": "2026-10-01T02:30:18.057273140Z",
"startTime": "2026-10-01T05:06:40.160465803Z",
"endTime": "2026-10-01T05:09:18.745111964Z",
"updateTime": "2026-10-01T05:09:18.745111964Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "gonk",
"id": "b566215d60249c8b54bcea4c401e358c7d855195",
"ref": "refs/heads/main"
}
}
}
[05:09:19.074] Invocation finished in 2h39m2.169877585s with status SUCCEEDED