[18:15:34.268] New invocation is queued and will start shortly
[18:15:35.336] Starting the invocation (attempt 1)
[18:15:35.363] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206"
[18:15:35.363] Popped gitiles commit info from properties and tags
[18:15:35.363] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:15:35.363] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:15:35.363] Buildbucket request:
{
"requestId": "8875320161547290576",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875320161547290576",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-san",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "10a055aad301f46cbe5fbe8f79e56d6a4ff71f4d"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@10a055aad301f46cbe5fbe8f79e56d6a4ff71f4d",
"title": "10a055aad301f46cbe5fbe8f79e56d6a4ff71f4d",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/10a055aad301f46cbe5fbe8f79e56d6a4ff71f4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "57d2afc82e321e6486ac98d279bf566b0a9f9952"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@57d2afc82e321e6486ac98d279bf566b0a9f9952",
"title": "57d2afc82e321e6486ac98d279bf566b0a9f9952",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/57d2afc82e321e6486ac98d279bf566b0a9f9952"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "3b7865b8bb9f5caf71fc79b17159793fe8d15624"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@3b7865b8bb9f5caf71fc79b17159793fe8d15624",
"title": "3b7865b8bb9f5caf71fc79b17159793fe8d15624",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/3b7865b8bb9f5caf71fc79b17159793fe8d15624"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "60e10377d598a9d65b46b9e41ad70d24a510c100"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@60e10377d598a9d65b46b9e41ad70d24a510c100",
"title": "60e10377d598a9d65b46b9e41ad70d24a510c100",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/60e10377d598a9d65b46b9e41ad70d24a510c100"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "c2055fc0124ccfa9d6aaaf5841d30aebc7f8fb3f"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@c2055fc0124ccfa9d6aaaf5841d30aebc7f8fb3f",
"title": "c2055fc0124ccfa9d6aaaf5841d30aebc7f8fb3f",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/c2055fc0124ccfa9d6aaaf5841d30aebc7f8fb3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206",
"title": "c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875320161547290576"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-san"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:15:35.838] Scheduled build:
{
"id": "8709890099662196337",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san"
},
"createdBy": "project:pigweed",
"createTime": "2025-07-08T18:15:35.439955536Z",
"updateTime": "2025-07-08T18:15:35.439955536Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206",
"ref": "refs/heads/main"
}
}
}
[18:15:35.838] Task URL: https://cr-buildbucket.appspot.com/build/8709890099662196337
[18:15:35.838] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:2:0) after 2m19s
[18:15:36.803] Received PubSub notification, asking Buildbucket for the build status
[18:15:36.830] Build status: SCHEDULED
[18:17:54.911] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:2:0)
[18:17:54.953] Build status: SCHEDULED
[18:17:54.953] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:4:0) after 8m25s
[18:26:19.992] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:4:0)
[18:26:20.021] Build status: SCHEDULED
[18:26:20.021] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:5:0) after 5m54s
[18:32:14.206] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:5:0)
[18:32:14.239] Build status: SCHEDULED
[18:32:14.239] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:6:0) after 1m8s
[18:33:22.252] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:6:0)
[18:33:22.268] Build status: SCHEDULED
[18:33:22.268] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:7:0) after 4m34s
[18:37:56.328] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:7:0)
[18:37:56.357] Build status: SCHEDULED
[18:37:56.357] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:8:0) after 8m19s
[18:46:15.486] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:8:0)
[18:46:15.507] Build status: SCHEDULED
[18:46:15.507] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:9:0) after 1m2s
[18:47:17.522] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:9:0)
[18:47:17.562] Build status: SCHEDULED
[18:47:17.563] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:10:0) after 5m58s
[18:53:15.669] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:10:0)
[18:53:15.702] Build status: SCHEDULED
[18:53:15.702] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:11:0) after 4m43s
[18:57:58.717] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:11:0)
[18:57:58.743] Build status: SCHEDULED
[18:57:58.743] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:12:0) after 2m28s
[19:00:26.851] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:12:0)
[19:00:26.878] Build status: SCHEDULED
[19:00:26.878] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:13:0) after 9m28s
[19:09:54.955] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:13:0)
[19:09:54.976] Build status: SCHEDULED
[19:09:54.976] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:14:0) after 5m43s
[19:15:38.039] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:14:0)
[19:15:38.203] Build status: SCHEDULED
[19:15:38.203] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:15:0) after 4m55s
[19:20:33.229] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:15:0)
[19:20:33.319] Build status: SCHEDULED
[19:20:33.319] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:16:0) after 9m46s
[19:30:19.411] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:16:0)
[19:30:19.462] Build status: SCHEDULED
[19:30:19.462] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:17:0) after 5m25s
[19:35:44.594] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:17:0)
[19:35:44.619] Build status: SCHEDULED
[19:35:44.619] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:18:0) after 1m31s
[19:37:15.642] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:18:0)
[19:37:15.673] Build status: SCHEDULED
[19:37:15.673] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:19:0) after 5m24s
[19:42:39.660] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:19:0)
[19:42:39.733] Build status: SCHEDULED
[19:42:39.733] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:20:0) after 9m23s
[19:52:02.850] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:20:0)
[19:52:02.894] Build status: SCHEDULED
[19:52:02.894] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:21:0) after 1m21s
[19:53:23.912] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:21:0)
[19:53:23.929] Build status: SCHEDULED
[19:53:23.929] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:22:0) after 2m3s
[19:55:26.994] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:22:0)
[19:55:27.013] Build status: SCHEDULED
[19:55:27.013] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:23:0) after 1m12s
[19:56:39.112] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:23:0)
[19:56:39.131] Build status: SCHEDULED
[19:56:39.131] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:24:0) after 2m4s
[19:58:43.154] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:24:0)
[19:58:43.188] Build status: SCHEDULED
[19:58:43.188] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:25:0) after 1m50s
[20:00:33.205] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:25:0)
[20:00:33.238] Build status: SCHEDULED
[20:00:33.238] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:26:0) after 3m28s
[20:04:01.264] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:26:0)
[20:04:01.287] Build status: SCHEDULED
[20:04:01.287] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:27:0) after 8m18s
[20:12:19.431] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:27:0)
[20:12:19.466] Build status: SCHEDULED
[20:12:19.466] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:28:0) after 7m29s
[20:19:48.535] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:28:0)
[20:19:48.560] Build status: SCHEDULED
[20:19:48.560] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:29:0) after 1m2s
[20:20:50.675] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:29:0)
[20:20:50.693] Build status: SCHEDULED
[20:20:50.693] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:30:0) after 6m23s
[20:27:13.706] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:30:0)
[20:27:13.726] Build status: SCHEDULED
[20:27:13.727] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:31:0) after 8m50s
[20:36:03.761] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:31:0)
[20:36:03.787] Build status: SCHEDULED
[20:36:03.787] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:32:0) after 9m11s
[20:45:15.092] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:32:0)
[20:45:15.122] Build status: SCHEDULED
[20:45:15.122] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:33:0) after 3m10s
[20:48:25.201] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:33:0)
[20:48:25.224] Build status: SCHEDULED
[20:48:25.224] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:34:0) after 7m27s
[20:50:27.115] Received PubSub notification, asking Buildbucket for the build status
[20:50:27.136] Build status: STARTED
[20:55:52.323] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:34:0)
[20:55:52.400] Build status: STARTED
[20:55:52.400] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:36:0) after 5m57s
[21:01:49.428] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:36:0)
[21:01:49.449] Build status: STARTED
[21:01:49.449] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:37:0) after 5m23s
[21:07:12.477] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:37:0)
[21:07:12.498] Build status: STARTED
[21:07:12.498] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:38:0) after 4m29s
[21:11:41.620] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:38:0)
[21:11:41.647] Build status: STARTED
[21:11:41.647] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-san:8875320161547290576:39:0) after 5m14s
[21:12:05.525] Received PubSub notification, asking Buildbucket for the build status
[21:12:05.548] Build:
{
"id": "8709890099662196337",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-san"
},
"createdBy": "project:pigweed",
"createTime": "2025-07-08T18:15:35.439955536Z",
"startTime": "2025-07-08T20:50:26.941957654Z",
"endTime": "2025-07-08T21:12:05.288126938Z",
"updateTime": "2025-07-08T21:12:05.288126938Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "c8d7e4b3213334c06c63b8b53aa9b3ecee2ff206",
"ref": "refs/heads/main"
}
}
}
[21:12:05.548] Invocation finished in 2h56m31.290523727s with status SUCCEEDED