[02:26:11.268] New invocation is queued and will start shortly
[02:26:12.346] Starting the invocation (attempt 1)
[02:26:12.372] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/2e15e17138ead6a9cbcde624b442d783575ed350"
[02:26:12.372] Popped gitiles commit info from properties and tags
[02:26:12.372] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:26:12.372] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:26:12.372] Buildbucket request:
{
"requestId": "8886160930576250192",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8886160930576250192",
"job": "pigweed/pigweed.dev.ci-pigweed-lintformat-full",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "eaa47707fca3e4bffd74201d9d963c73030d8a4d"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@eaa47707fca3e4bffd74201d9d963c73030d8a4d",
"title": "eaa47707fca3e4bffd74201d9d963c73030d8a4d",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/eaa47707fca3e4bffd74201d9d963c73030d8a4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "808ac9e228212023358fe1cb7cdd8bfcfcb445e8"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@808ac9e228212023358fe1cb7cdd8bfcfcb445e8",
"title": "808ac9e228212023358fe1cb7cdd8bfcfcb445e8",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/808ac9e228212023358fe1cb7cdd8bfcfcb445e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "bf2e1563e54b40df91cadf29d27d4ef247762983"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@bf2e1563e54b40df91cadf29d27d4ef247762983",
"title": "bf2e1563e54b40df91cadf29d27d4ef247762983",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/bf2e1563e54b40df91cadf29d27d4ef247762983"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "2e15e17138ead6a9cbcde624b442d783575ed350"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@2e15e17138ead6a9cbcde624b442d783575ed350",
"title": "2e15e17138ead6a9cbcde624b442d783575ed350",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/2e15e17138ead6a9cbcde624b442d783575ed350"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "2e15e17138ead6a9cbcde624b442d783575ed350",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8886160930576250192"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-lintformat-full"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:26:13.357] Scheduled build:
{
"id": "8720730868712105249",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"createdBy": "project:pigweed",
"createTime": "2025-03-11T02:26:12.426286967Z",
"updateTime": "2025-03-11T02:26:12.426286967Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "2e15e17138ead6a9cbcde624b442d783575ed350",
"ref": "refs/heads/main"
}
}
}
[02:26:13.357] Task URL: https://cr-buildbucket.appspot.com/build/8720730868712105249
[02:26:13.357] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:2:0) after 9m36s
[02:26:13.789] Received PubSub notification, asking Buildbucket for the build status
[02:26:13.877] Build status: SCHEDULED
[02:35:49.412] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:2:0)
[02:35:49.442] Build status: SCHEDULED
[02:35:49.442] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:4:0) after 7m31s
[02:43:20.443] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:4:0)
[02:43:20.462] Build status: SCHEDULED
[02:43:20.462] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:5:0) after 2m44s
[02:46:04.486] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:5:0)
[02:46:04.505] Build status: SCHEDULED
[02:46:04.505] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:6:0) after 9m52s
[02:55:56.851] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:6:0)
[02:55:56.868] Build status: SCHEDULED
[02:55:56.868] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:7:0) after 1m2s
[02:56:58.895] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:7:0)
[02:56:58.911] Build status: SCHEDULED
[02:56:58.911] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:8:0) after 5m19s
[03:02:17.930] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:8:0)
[03:02:17.959] Build status: SCHEDULED
[03:02:17.959] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:9:0) after 2m27s
[03:04:44.976] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:9:0)
[03:04:45.001] Build status: SCHEDULED
[03:04:45.001] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:10:0) after 6m26s
[03:11:11.212] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:10:0)
[03:11:11.231] Build status: SCHEDULED
[03:11:11.231] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:11:0) after 6m42s
[03:17:53.252] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:11:0)
[03:17:53.269] Build status: SCHEDULED
[03:17:53.269] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:12:0) after 3m57s
[03:21:50.456] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:12:0)
[03:21:50.512] Build status: SCHEDULED
[03:21:50.512] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:13:0) after 1m50s
[03:23:40.675] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:13:0)
[03:23:40.703] Build status: SCHEDULED
[03:23:40.703] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:14:0) after 3m34s
[03:27:14.734] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:14:0)
[03:27:14.752] Build status: SCHEDULED
[03:27:14.752] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:15:0) after 8m5s
[03:35:20.121] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:15:0)
[03:35:20.149] Build status: SCHEDULED
[03:35:20.149] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:16:0) after 7m44s
[03:43:04.166] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:16:0)
[03:43:04.184] Build status: SCHEDULED
[03:43:04.184] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:17:0) after 2m47s
[03:45:51.294] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:17:0)
[03:45:51.316] Build status: SCHEDULED
[03:45:51.316] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:18:0) after 2m58s
[03:48:49.341] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:18:0)
[03:48:49.495] Build status: SCHEDULED
[03:48:49.495] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:19:0) after 5m45s
[03:54:34.520] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:19:0)
[03:54:34.535] Build status: SCHEDULED
[03:54:34.535] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:20:0) after 1m21s
[03:55:55.547] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:20:0)
[03:55:55.567] Build status: SCHEDULED
[03:55:55.567] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:21:0) after 4m10s
[04:00:05.680] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:21:0)
[04:00:05.701] Build status: SCHEDULED
[04:00:05.701] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:22:0) after 1m27s
[04:01:32.721] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:22:0)
[04:01:32.740] Build status: SCHEDULED
[04:01:32.740] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:23:0) after 9m3s
[04:10:35.805] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:23:0)
[04:10:35.834] Build status: SCHEDULED
[04:10:35.834] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:24:0) after 4m12s
[04:14:47.910] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:24:0)
[04:14:47.924] Build status: SCHEDULED
[04:14:47.924] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:25:0) after 6m8s
[04:20:55.992] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:25:0)
[04:20:56.013] Build status: SCHEDULED
[04:20:56.013] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:26:0) after 6m53s
[04:27:49.033] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:26:0)
[04:27:49.055] Build status: SCHEDULED
[04:27:49.055] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:27:0) after 6m24s
[04:34:13.562] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:27:0)
[04:34:13.590] Build status: SCHEDULED
[04:34:13.591] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:28:0) after 8m10s
[04:42:23.667] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:28:0)
[04:42:23.685] Build status: SCHEDULED
[04:42:23.685] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:29:0) after 4m25s
[04:46:48.743] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:29:0)
[04:46:48.765] Build status: SCHEDULED
[04:46:48.765] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:30:0) after 4m51s
[04:51:39.788] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:30:0)
[04:51:39.809] Build status: SCHEDULED
[04:51:39.809] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:31:0) after 5m26s
[04:57:05.833] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:31:0)
[04:57:05.850] Build status: SCHEDULED
[04:57:05.850] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:32:0) after 3m59s
[05:01:04.833] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:32:0)
[05:01:04.872] Build status: SCHEDULED
[05:01:04.873] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:33:0) after 5m8s
[05:06:13.903] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:33:0)
[05:06:13.929] Build status: SCHEDULED
[05:06:13.929] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:34:0) after 8m6s
[05:14:19.961] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:34:0)
[05:14:20.004] Build status: SCHEDULED
[05:14:20.004] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:35:0) after 9m49s
[05:24:09.063] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:35:0)
[05:24:09.137] Build status: SCHEDULED
[05:24:09.137] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:36:0) after 3m52s
[05:28:01.286] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:36:0)
[05:28:01.384] Build status: SCHEDULED
[05:28:01.384] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:37:0) after 3m22s
[05:31:23.919] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:37:0)
[05:31:23.937] Build status: SCHEDULED
[05:31:23.937] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:38:0) after 5m57s
[05:37:20.954] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:38:0)
[05:37:20.974] Build status: SCHEDULED
[05:37:20.974] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:39:0) after 6m57s
[05:44:18.054] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:39:0)
[05:44:18.073] Build status: SCHEDULED
[05:44:18.073] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:40:0) after 8m52s
[05:53:10.508] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:40:0)
[05:53:10.531] Build status: SCHEDULED
[05:53:10.531] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:41:0) after 6m22s
[05:59:32.557] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:41:0)
[05:59:32.575] Build status: SCHEDULED
[05:59:32.575] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:42:0) after 4m24s
[06:03:56.597] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:42:0)
[06:03:56.621] Build status: SCHEDULED
[06:03:56.621] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:43:0) after 3m36s
[06:07:32.656] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:43:0)
[06:07:32.675] Build status: SCHEDULED
[06:07:32.675] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:44:0) after 8m49s
[06:16:22.240] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:44:0)
[06:16:22.281] Build status: SCHEDULED
[06:16:22.281] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:45:0) after 3m13s
[06:19:35.413] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:45:0)
[06:19:35.487] Build status: SCHEDULED
[06:19:35.487] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:46:0) after 7m41s
[06:23:11.495] Received PubSub notification, asking Buildbucket for the build status
[06:23:11.561] Build status: STARTED
[06:27:16.512] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:46:0)
[06:27:16.535] Build status: STARTED
[06:27:16.535] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:48:0) after 7m46s
[06:35:02.752] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:48:0)
[06:35:02.799] Build status: STARTED
[06:35:02.799] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8886160930576250192:49:0) after 7m7s
[06:41:17.912] Received PubSub notification, asking Buildbucket for the build status
[06:41:17.946] Build:
{
"id": "8720730868712105249",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"createdBy": "project:pigweed",
"createTime": "2025-03-11T02:26:12.426286967Z",
"startTime": "2025-03-11T06:23:11.269121612Z",
"endTime": "2025-03-11T06:41:00.362056805Z",
"updateTime": "2025-03-11T06:41:00.362056805Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "2e15e17138ead6a9cbcde624b442d783575ed350",
"ref": "refs/heads/main"
}
}
}
[06:41:17.946] Invocation finished in 4h15m6.682254264s with status SUCCEEDED