[01:03:00.476] New invocation is queued and will start shortly
[01:03:02.396] Starting the invocation (attempt 1)
[01:03:02.432] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/bc400270c74c85947dbd44571be014189f720a03"
[01:03:02.432] Popped gitiles commit info from properties and tags
[01:03:02.432] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:03:02.432] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:03:02.432] Buildbucket request:
{
"requestId": "8891239593926578608",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-integration"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8891239593926578608",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "f41ac1468aef988eefbdc59629652f24d22a5cff"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@f41ac1468aef988eefbdc59629652f24d22a5cff",
"title": "f41ac1468aef988eefbdc59629652f24d22a5cff",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/f41ac1468aef988eefbdc59629652f24d22a5cff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "00f6395e942f2807a2c5ce0afeb377f2f15585e9"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@00f6395e942f2807a2c5ce0afeb377f2f15585e9",
"title": "00f6395e942f2807a2c5ce0afeb377f2f15585e9",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/00f6395e942f2807a2c5ce0afeb377f2f15585e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "6053b3c6fb644c4a506a324eb43e5acd36ba7aff"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@6053b3c6fb644c4a506a324eb43e5acd36ba7aff",
"title": "6053b3c6fb644c4a506a324eb43e5acd36ba7aff",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/6053b3c6fb644c4a506a324eb43e5acd36ba7aff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "9735377a82ea3c685192257e07b55c4295ce27fe"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@9735377a82ea3c685192257e07b55c4295ce27fe",
"title": "9735377a82ea3c685192257e07b55c4295ce27fe",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/9735377a82ea3c685192257e07b55c4295ce27fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "2f4c98a4812bc94c93e04cfe5fb08f8091bfaaaf"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@2f4c98a4812bc94c93e04cfe5fb08f8091bfaaaf",
"title": "2f4c98a4812bc94c93e04cfe5fb08f8091bfaaaf",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/2f4c98a4812bc94c93e04cfe5fb08f8091bfaaaf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "a8f3d5ebc9b17f4f0d6c093cadb51950e88bd751"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@a8f3d5ebc9b17f4f0d6c093cadb51950e88bd751",
"title": "a8f3d5ebc9b17f4f0d6c093cadb51950e88bd751",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/a8f3d5ebc9b17f4f0d6c093cadb51950e88bd751"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "bc400270c74c85947dbd44571be014189f720a03"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@bc400270c74c85947dbd44571be014189f720a03",
"title": "bc400270c74c85947dbd44571be014189f720a03",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/bc400270c74c85947dbd44571be014189f720a03"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "bc400270c74c85947dbd44571be014189f720a03",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8891239593926578608"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:03:02.948] Scheduled build:
{
"id": "8725809531147496145",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-integration"
},
"createdBy": "project:pigweed",
"createTime": "2025-01-14T01:03:02.499444235Z",
"updateTime": "2025-01-14T01:03:02.499444235Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "bc400270c74c85947dbd44571be014189f720a03",
"ref": "refs/heads/main"
}
}
}
[01:03:02.948] Task URL: https://cr-buildbucket.appspot.com/build/8725809531147496145
[01:03:02.948] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:2:0) after 4m37s
[01:03:03.935] Received PubSub notification, asking Buildbucket for the build status
[01:03:03.963] Build status: SCHEDULED
[01:07:40.001] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:2:0)
[01:07:40.032] Build status: SCHEDULED
[01:07:40.032] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:4:0) after 2m19s
[01:09:59.050] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:4:0)
[01:09:59.075] Build status: SCHEDULED
[01:09:59.075] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:5:0) after 7m44s
[01:17:43.105] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:5:0)
[01:17:43.131] Build status: SCHEDULED
[01:17:43.131] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:6:0) after 9m25s
[01:27:08.204] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:6:0)
[01:27:08.257] Build status: SCHEDULED
[01:27:08.257] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:7:0) after 4m52s
[01:32:00.280] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:7:0)
[01:32:00.310] Build status: SCHEDULED
[01:32:00.310] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:8:0) after 6m12s
[01:38:12.829] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:8:0)
[01:38:12.859] Build status: SCHEDULED
[01:38:12.859] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:9:0) after 5m45s
[01:43:57.923] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:9:0)
[01:43:58.113] Build status: SCHEDULED
[01:43:58.113] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:10:0) after 3m49s
[01:47:47.179] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:10:0)
[01:47:47.197] Build status: SCHEDULED
[01:47:47.197] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:11:0) after 1m56s
[01:49:43.213] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:11:0)
[01:49:43.240] Build status: SCHEDULED
[01:49:43.240] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:12:0) after 2m36s
[01:52:19.246] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:12:0)
[01:52:19.265] Build status: SCHEDULED
[01:52:19.265] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:13:0) after 4m35s
[01:56:54.712] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:13:0)
[01:56:54.729] Build status: SCHEDULED
[01:56:54.729] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:14:0) after 2m7s
[01:59:01.940] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:14:0)
[01:59:01.974] Build status: SCHEDULED
[01:59:01.974] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:15:0) after 2m12s
[02:01:14.138] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:15:0)
[02:01:14.155] Build status: SCHEDULED
[02:01:14.155] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:16:0) after 2m56s
[02:04:10.282] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:16:0)
[02:04:10.301] Build status: SCHEDULED
[02:04:10.301] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:17:0) after 5m14s
[02:09:24.422] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:17:0)
[02:09:24.439] Build status: SCHEDULED
[02:09:24.439] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:18:0) after 9m3s
[02:18:27.456] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:18:0)
[02:18:27.487] Build status: SCHEDULED
[02:18:27.487] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:19:0) after 7m7s
[02:25:34.513] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:19:0)
[02:25:34.595] Build status: SCHEDULED
[02:25:34.595] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:20:0) after 1m7s
[02:26:41.610] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:20:0)
[02:26:41.626] Build status: SCHEDULED
[02:26:41.626] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:21:0) after 7m33s
[02:34:14.647] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:21:0)
[02:34:14.671] Build status: SCHEDULED
[02:34:14.671] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:22:0) after 1m5s
[02:35:19.688] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:22:0)
[02:35:19.711] Build status: SCHEDULED
[02:35:19.711] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:23:0) after 2m16s
[02:37:35.699] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:23:0)
[02:37:35.716] Build status: SCHEDULED
[02:37:35.716] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:24:0) after 1m54s
[02:39:29.733] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:24:0)
[02:39:29.753] Build status: SCHEDULED
[02:39:29.753] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:25:0) after 9m13s
[02:48:42.772] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:25:0)
[02:48:42.791] Build status: SCHEDULED
[02:48:42.791] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:26:0) after 2m16s
[02:50:58.851] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:26:0)
[02:50:58.872] Build status: SCHEDULED
[02:50:58.872] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:27:0) after 9m15s
[03:00:13.947] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:27:0)
[03:00:13.971] Build status: SCHEDULED
[03:00:13.972] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:28:0) after 6m42s
[03:06:55.996] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:28:0)
[03:06:56.054] Build status: SCHEDULED
[03:06:56.054] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:29:0) after 6m19s
[03:13:15.087] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:29:0)
[03:13:15.113] Build status: SCHEDULED
[03:13:15.113] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:30:0) after 7m25s
[03:20:40.150] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:30:0)
[03:20:40.218] Build status: SCHEDULED
[03:20:40.218] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:31:0) after 4m28s
[03:25:08.234] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:31:0)
[03:25:08.352] Build status: SCHEDULED
[03:25:08.352] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:32:0) after 1m39s
[03:26:47.379] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:32:0)
[03:26:47.575] Build status: SCHEDULED
[03:26:47.575] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:33:0) after 2m6s
[03:28:53.739] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:33:0)
[03:28:53.756] Build status: SCHEDULED
[03:28:53.756] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:34:0) after 8m3s
[03:36:56.750] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:34:0)
[03:36:56.769] Build status: SCHEDULED
[03:36:56.769] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:35:0) after 6m59s
[03:43:55.787] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:35:0)
[03:43:55.816] Build status: SCHEDULED
[03:43:55.816] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:36:0) after 9m52s
[03:53:47.842] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:36:0)
[03:53:47.872] Build status: SCHEDULED
[03:53:47.872] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:37:0) after 1m7s
[03:54:54.892] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:37:0)
[03:54:54.910] Build status: SCHEDULED
[03:54:54.910] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-integration:8891239593926578608:38:0) after 5m1s
[03:57:44.734] Received PubSub notification, asking Buildbucket for the build status
[03:57:44.786] Build status: STARTED
[03:59:19.200] Received PubSub notification, asking Buildbucket for the build status
[03:59:19.216] Build:
{
"id": "8725809531147496145",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-integration"
},
"createdBy": "project:pigweed",
"createTime": "2025-01-14T01:03:02.499444235Z",
"startTime": "2025-01-14T03:57:44.253456570Z",
"endTime": "2025-01-14T03:59:18.837609635Z",
"updateTime": "2025-01-14T03:59:18.837609635Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "bc400270c74c85947dbd44571be014189f720a03",
"ref": "refs/heads/main"
}
}
}
[03:59:19.216] Invocation finished in 2h56m18.75114345s with status SUCCEEDED