[22:15:55.352] New invocation is queued and will start shortly
[22:15:56.525] Starting the invocation (attempt 1)
[22:15:56.558] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/768c441e6ea4b133a29262d44f7c17c88c83359f"
[22:15:56.558] Popped gitiles commit info from properties and tags
[22:15:56.558] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:15:56.558] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:15:56.558] Buildbucket request:
{
"requestId": "8921690686739545088",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-cmake-host-clang"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8921690686739545088",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "9909bd4146807564e6a8a48cd316d7fa62ed6e33"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@9909bd4146807564e6a8a48cd316d7fa62ed6e33",
"title": "9909bd4146807564e6a8a48cd316d7fa62ed6e33",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/9909bd4146807564e6a8a48cd316d7fa62ed6e33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "768c441e6ea4b133a29262d44f7c17c88c83359f"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@768c441e6ea4b133a29262d44f7c17c88c83359f",
"title": "768c441e6ea4b133a29262d44f7c17c88c83359f",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/768c441e6ea4b133a29262d44f7c17c88c83359f"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "768c441e6ea4b133a29262d44f7c17c88c83359f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8921690686739545088"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:15:57.235] Scheduled build:
{
"id": "8756260624683473601",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-cmake-host-clang"
},
"createdBy": "project:pigweed",
"createTime": "2024-02-12T22:15:56.688970269Z",
"updateTime": "2024-02-12T22:15:56.688970269Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "768c441e6ea4b133a29262d44f7c17c88c83359f",
"ref": "refs/heads/main"
}
}
}
[22:15:57.235] Task URL: https://cr-buildbucket.appspot.com/build/8756260624683473601
[22:15:57.235] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:2:0) after 9m25s
[22:15:58.122] Received PubSub notification, asking Buildbucket for the build status
[22:15:58.166] Build status: SCHEDULED
[22:25:22.364] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:2:0)
[22:25:22.419] Build status: SCHEDULED
[22:25:22.420] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:4:0) after 7m21s
[22:32:43.623] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:4:0)
[22:32:43.697] Build status: SCHEDULED
[22:32:43.697] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:5:0) after 5m49s
[22:38:32.885] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:5:0)
[22:38:32.920] Build status: SCHEDULED
[22:38:32.920] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:6:0) after 8m49s
[22:47:21.931] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:6:0)
[22:47:23.541] Build status: SCHEDULED
[22:47:23.541] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:7:0) after 7m38s
[22:55:01.567] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:7:0)
[22:55:01.605] Build status: SCHEDULED
[22:55:01.605] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:8:0) after 9m17s
[23:04:18.741] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:8:0)
[23:04:18.787] Build status: SCHEDULED
[23:04:18.787] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:9:0) after 2m58s
[23:07:17.036] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:9:0)
[23:07:17.151] Build status: SCHEDULED
[23:07:17.151] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:10:0) after 3m12s
[23:10:29.401] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:10:0)
[23:10:29.448] Build status: SCHEDULED
[23:10:29.448] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:11:0) after 2m11s
[23:12:40.544] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:11:0)
[23:12:40.640] Build status: SCHEDULED
[23:12:40.640] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:12:0) after 3m37s
[23:16:17.882] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:12:0)
[23:16:17.915] Build status: SCHEDULED
[23:16:17.915] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:13:0) after 2m17s
[23:18:34.939] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:13:0)
[23:18:34.991] Build status: SCHEDULED
[23:18:34.991] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:14:0) after 6m7s
[23:24:42.039] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:14:0)
[23:24:42.238] Build status: SCHEDULED
[23:24:42.238] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:15:0) after 8m26s
[23:33:08.313] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:15:0)
[23:33:08.387] Build status: SCHEDULED
[23:33:08.387] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:16:0) after 3m25s
[23:36:33.407] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:16:0)
[23:36:33.436] Build status: SCHEDULED
[23:36:33.436] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:17:0) after 7m25s
[23:43:58.511] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:17:0)
[23:43:58.538] Build status: SCHEDULED
[23:43:58.538] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:18:0) after 9m53s
[23:53:51.561] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:18:0)
[23:53:51.583] Build status: SCHEDULED
[23:53:51.583] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:19:0) after 7m48s
[00:01:39.592] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:19:0)
[00:01:39.615] Build status: SCHEDULED
[00:01:39.615] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:20:0) after 3m2s
[00:04:41.660] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:20:0)
[00:04:41.701] Build status: SCHEDULED
[00:04:41.701] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:21:0) after 6m15s
[00:10:56.720] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:21:0)
[00:10:56.750] Build status: SCHEDULED
[00:10:56.750] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:22:0) after 4m24s
[00:15:20.781] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:22:0)
[00:15:20.801] Build status: SCHEDULED
[00:15:20.801] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:23:0) after 9m9s
[00:24:29.818] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:23:0)
[00:24:29.837] Build status: SCHEDULED
[00:24:29.837] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:24:0) after 9m27s
[00:33:57.210] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:24:0)
[00:33:57.241] Build status: SCHEDULED
[00:33:57.241] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:25:0) after 7m54s
[00:41:51.277] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:25:0)
[00:41:51.308] Build status: SCHEDULED
[00:41:51.308] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:26:0) after 6m33s
[00:48:24.340] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:26:0)
[00:48:24.403] Build status: SCHEDULED
[00:48:24.403] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:27:0) after 3m31s
[00:48:56.024] Received PubSub notification, asking Buildbucket for the build status
[00:48:56.049] Build status: STARTED
[00:51:55.638] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:27:0)
[00:51:55.656] Build status: STARTED
[00:51:55.656] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-cmake-host-clang:8921690686739545088:29:0) after 2m43s
[00:53:14.973] Received PubSub notification, asking Buildbucket for the build status
[00:53:15.125] Build:
{
"id": "8756260624683473601",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-cmake-host-clang"
},
"createdBy": "project:pigweed",
"createTime": "2024-02-12T22:15:56.688970269Z",
"startTime": "2024-02-13T00:48:55.485982Z",
"endTime": "2024-02-13T00:53:14.436763Z",
"updateTime": "2024-02-13T00:53:14.436763Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "768c441e6ea4b133a29262d44f7c17c88c83359f",
"ref": "refs/heads/main"
}
}
}
[00:53:15.125] Invocation finished in 2h37m19.781511029s with status SUCCEEDED