[02:23:41.248] New invocation is queued and will start shortly
[02:23:42.365] Starting the invocation (attempt 1)
[02:23:42.391] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/7da28cae44db28dc877eb245dd817b5b1df6ec9f"
[02:23:42.391] Popped gitiles commit info from properties and tags
[02:23:42.391] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:23:42.392] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:23:42.392] Buildbucket request:
{
"requestId": "8885164521257432176",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-bazel-main"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8885164521257432176",
"job": "pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "5bd503e38c91c696c22756ea961570df93e2c8c5"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@5bd503e38c91c696c22756ea961570df93e2c8c5",
"title": "5bd503e38c91c696c22756ea961570df93e2c8c5",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/5bd503e38c91c696c22756ea961570df93e2c8c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "b47d1ac00bd8b51bfe6a92eb64eb8b658df84011"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@b47d1ac00bd8b51bfe6a92eb64eb8b658df84011",
"title": "b47d1ac00bd8b51bfe6a92eb64eb8b658df84011",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/b47d1ac00bd8b51bfe6a92eb64eb8b658df84011"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "7da28cae44db28dc877eb245dd817b5b1df6ec9f"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@7da28cae44db28dc877eb245dd817b5b1df6ec9f",
"title": "7da28cae44db28dc877eb245dd817b5b1df6ec9f",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/7da28cae44db28dc877eb245dd817b5b1df6ec9f"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "7da28cae44db28dc877eb245dd817b5b1df6ec9f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8885164521257432176"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:23:42.739] Scheduled build:
{
"id": "8719734459351365969",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-bazel-main"
},
"createdBy": "project:pigweed",
"createTime": "2025-03-22T02:23:42.442164447Z",
"updateTime": "2025-03-22T02:23:42.442164447Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "7da28cae44db28dc877eb245dd817b5b1df6ec9f",
"ref": "refs/heads/main"
}
}
}
[02:23:42.739] Task URL: https://cr-buildbucket.appspot.com/build/8719734459351365969
[02:23:42.739] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:2:0) after 5m41s
[02:23:43.471] Received PubSub notification, asking Buildbucket for the build status
[02:23:43.491] Build status: SCHEDULED
[02:29:24.342] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:2:0)
[02:29:24.380] Build status: SCHEDULED
[02:29:24.380] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:4:0) after 8m5s
[02:37:29.512] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:4:0)
[02:37:29.540] Build status: SCHEDULED
[02:37:29.540] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:5:0) after 8m8s
[02:45:37.627] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:5:0)
[02:45:37.676] Build status: SCHEDULED
[02:45:37.676] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:6:0) after 9m28s
[02:55:05.795] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:6:0)
[02:55:05.819] Build status: SCHEDULED
[02:55:05.819] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:7:0) after 5m49s
[03:00:55.118] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:7:0)
[03:00:55.153] Build status: SCHEDULED
[03:00:55.153] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:8:0) after 5m1s
[03:05:56.268] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:8:0)
[03:05:56.285] Build status: SCHEDULED
[03:05:56.285] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:9:0) after 2m56s
[03:08:52.544] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:9:0)
[03:08:52.561] Build status: SCHEDULED
[03:08:52.561] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:10:0) after 5m35s
[03:14:27.618] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:10:0)
[03:14:27.777] Build status: SCHEDULED
[03:14:27.778] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:11:0) after 3m45s
[03:18:12.972] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:11:0)
[03:18:13.000] Build status: SCHEDULED
[03:18:13.000] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:12:0) after 8m27s
[03:26:40.014] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:12:0)
[03:26:40.054] Build status: SCHEDULED
[03:26:40.054] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:13:0) after 4m1s
[03:30:41.090] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:13:0)
[03:30:41.117] Build status: SCHEDULED
[03:30:41.117] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:14:0) after 9m29s
[03:40:10.208] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:14:0)
[03:40:10.225] Build status: SCHEDULED
[03:40:10.225] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:15:0) after 5m9s
[03:45:19.498] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:15:0)
[03:45:19.515] Build status: SCHEDULED
[03:45:19.515] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:16:0) after 5m40s
[03:50:59.539] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:16:0)
[03:50:59.558] Build status: SCHEDULED
[03:50:59.558] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:17:0) after 6m5s
[03:57:04.678] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:17:0)
[03:57:04.697] Build status: SCHEDULED
[03:57:04.697] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:18:0) after 6m16s
[04:03:20.840] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:18:0)
[04:03:20.856] Build status: SCHEDULED
[04:03:20.856] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:19:0) after 3m59s
[04:07:20.261] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:19:0)
[04:07:20.282] Build status: SCHEDULED
[04:07:20.282] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:20:0) after 7m15s
[04:14:35.763] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:20:0)
[04:14:35.778] Build status: SCHEDULED
[04:14:35.778] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:21:0) after 9m31s
[04:24:06.903] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:21:0)
[04:24:06.916] Build status: SCHEDULED
[04:24:06.916] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:22:0) after 6m59s
[04:31:05.938] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:22:0)
[04:31:05.966] Build status: SCHEDULED
[04:31:05.966] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:23:0) after 8m2s
[04:39:07.989] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:23:0)
[04:39:08.030] Build status: SCHEDULED
[04:39:08.030] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:24:0) after 7m7s
[04:46:15.065] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:24:0)
[04:46:15.082] Build status: SCHEDULED
[04:46:15.082] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:25:0) after 7m19s
[04:53:34.110] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:25:0)
[04:53:34.216] Build status: SCHEDULED
[04:53:34.216] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:26:0) after 7m2s
[05:00:36.537] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:26:0)
[05:00:36.556] Build status: SCHEDULED
[05:00:36.556] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:27:0) after 5m50s
[05:06:26.701] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:27:0)
[05:06:26.733] Build status: SCHEDULED
[05:06:26.733] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:28:0) after 9m23s
[05:15:49.856] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:28:0)
[05:15:49.871] Build status: SCHEDULED
[05:15:49.871] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:29:0) after 2m24s
[05:18:13.893] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:29:0)
[05:18:13.913] Build status: SCHEDULED
[05:18:13.913] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:30:0) after 2m0s
[05:20:14.017] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:30:0)
[05:20:14.036] Build status: SCHEDULED
[05:20:14.036] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:31:0) after 5m10s
[05:25:24.060] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:31:0)
[05:25:24.077] Build status: SCHEDULED
[05:25:24.077] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:32:0) after 9m27s
[05:34:51.580] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:32:0)
[05:34:51.602] Build status: SCHEDULED
[05:34:51.602] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:33:0) after 1m18s
[05:36:09.613] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:33:0)
[05:36:09.629] Build status: SCHEDULED
[05:36:09.629] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:34:0) after 4m29s
[05:40:38.653] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:34:0)
[05:40:38.667] Build status: SCHEDULED
[05:40:38.667] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:35:0) after 6m3s
[05:46:41.710] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:35:0)
[05:46:41.729] Build status: SCHEDULED
[05:46:41.729] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:36:0) after 1m13s
[05:47:54.840] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:36:0)
[05:47:54.868] Build status: SCHEDULED
[05:47:54.868] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:37:0) after 9m39s
[05:57:34.121] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:37:0)
[05:57:34.138] Build status: SCHEDULED
[05:57:34.138] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:38:0) after 2m32s
[05:58:14.384] Received PubSub notification, asking Buildbucket for the build status
[05:58:14.399] Build status: STARTED
[06:00:06.182] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:38:0)
[06:00:06.213] Build status: STARTED
[06:00:06.214] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:40:0) after 5m34s
[06:05:40.472] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:40:0)
[06:05:40.506] Build status: STARTED
[06:05:40.506] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:41:0) after 9m54s
[06:15:34.834] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:41:0)
[06:15:34.850] Build status: STARTED
[06:15:34.850] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:42:0) after 3m2s
[06:18:36.887] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:42:0)
[06:18:36.914] Build status: STARTED
[06:18:36.914] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-mac-arm-bazel-main:8885164521257432176:43:0) after 3m51s
[06:21:27.839] Received PubSub notification, asking Buildbucket for the build status
[06:21:27.856] Build:
{
"id": "8719734459351365969",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-mac-arm-bazel-main"
},
"createdBy": "project:pigweed",
"createTime": "2025-03-22T02:23:42.442164447Z",
"startTime": "2025-03-22T05:58:13.223845108Z",
"endTime": "2025-03-22T06:21:27.455070292Z",
"updateTime": "2025-03-22T06:21:27.455070292Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "7da28cae44db28dc877eb245dd817b5b1df6ec9f",
"ref": "refs/heads/main"
}
}
}
[06:21:27.856] Invocation finished in 3h57m46.616218726s with status SUCCEEDED