[17:55:26.904] New invocation is queued and will start shortly
[17:55:27.979] Starting the invocation (attempt 1)
[17:55:28.008] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/e6c5165547f305416c6d11b1a911e912f2aecb6b"
[17:55:28.008] Popped gitiles commit info from properties and tags
[17:55:28.008] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:55:28.008] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:55:28.008] Buildbucket request:
{
"requestId": "8910110662660897424",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-bthost"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910110662660897424",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "e6c5165547f305416c6d11b1a911e912f2aecb6b"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@e6c5165547f305416c6d11b1a911e912f2aecb6b",
"title": "e6c5165547f305416c6d11b1a911e912f2aecb6b",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/e6c5165547f305416c6d11b1a911e912f2aecb6b"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "e6c5165547f305416c6d11b1a911e912f2aecb6b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910110662660897424"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:55:28.481] Scheduled build:
{
"id": "8744680600720611633",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-bthost"
},
"createdBy": "project:pigweed",
"createTime": "2024-06-19T17:55:28.124526866Z",
"updateTime": "2024-06-19T17:55:28.124526866Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "e6c5165547f305416c6d11b1a911e912f2aecb6b",
"ref": "refs/heads/main"
}
}
}
[17:55:28.481] Task URL: https://cr-buildbucket.appspot.com/build/8744680600720611633
[17:55:28.481] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:2:0) after 6m52s
[17:55:29.485] Received PubSub notification, asking Buildbucket for the build status
[17:55:29.502] Build status: SCHEDULED
[18:02:20.595] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:2:0)
[18:02:20.701] Build status: SCHEDULED
[18:02:20.701] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:4:0) after 5m26s
[18:07:46.828] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:4:0)
[18:07:46.850] Build status: SCHEDULED
[18:07:46.850] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:5:0) after 4m18s
[18:12:04.866] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:5:0)
[18:12:04.887] Build status: SCHEDULED
[18:12:04.887] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:6:0) after 7m24s
[18:19:28.920] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:6:0)
[18:19:28.945] Build status: SCHEDULED
[18:19:28.945] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:7:0) after 6m43s
[18:26:11.977] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:7:0)
[18:26:11.998] Build status: SCHEDULED
[18:26:11.998] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:8:0) after 6m16s
[18:32:28.171] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:8:0)
[18:32:28.202] Build status: SCHEDULED
[18:32:28.202] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:9:0) after 8m29s
[18:40:57.493] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:9:0)
[18:40:57.511] Build status: SCHEDULED
[18:40:57.511] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:10:0) after 2m27s
[18:43:24.557] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:10:0)
[18:43:24.589] Build status: SCHEDULED
[18:43:24.589] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:11:0) after 8m20s
[18:51:44.620] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:11:0)
[18:51:44.642] Build status: SCHEDULED
[18:51:44.642] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:12:0) after 1m40s
[18:53:24.662] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:12:0)
[18:53:24.695] Build status: SCHEDULED
[18:53:24.695] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:13:0) after 7m58s
[19:01:22.961] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:13:0)
[19:01:22.979] Build status: SCHEDULED
[19:01:22.979] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:14:0) after 8m33s
[19:09:56.232] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:14:0)
[19:09:56.260] Build status: SCHEDULED
[19:09:56.260] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:15:0) after 3m32s
[19:13:28.496] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:15:0)
[19:13:28.519] Build status: SCHEDULED
[19:13:28.519] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:16:0) after 4m45s
[19:18:13.557] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:16:0)
[19:18:13.574] Build status: SCHEDULED
[19:18:13.574] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:17:0) after 6m58s
[19:25:11.618] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:17:0)
[19:25:11.638] Build status: SCHEDULED
[19:25:11.638] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:18:0) after 5m54s
[19:31:05.746] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:18:0)
[19:31:05.774] Build status: SCHEDULED
[19:31:05.774] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:19:0) after 2m14s
[19:33:19.967] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:19:0)
[19:33:19.990] Build status: SCHEDULED
[19:33:19.990] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:20:0) after 7m27s
[19:40:47.277] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:20:0)
[19:40:47.298] Build status: SCHEDULED
[19:40:47.298] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:21:0) after 6m1s
[19:46:48.461] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:21:0)
[19:46:48.479] Build status: SCHEDULED
[19:46:48.479] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:22:0) after 6m50s
[19:53:38.834] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:22:0)
[19:53:38.852] Build status: SCHEDULED
[19:53:38.852] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:23:0) after 2m1s
[19:55:40.101] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:23:0)
[19:55:40.133] Build status: SCHEDULED
[19:55:40.133] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-bazel-bthost:8910110662660897424:24:0) after 8m40s
[19:57:50.749] Received PubSub notification, asking Buildbucket for the build status
[19:57:50.768] Build status: STARTED
[20:01:59.975] Received PubSub notification, asking Buildbucket for the build status
[20:01:59.995] Build:
{
"id": "8744680600720611633",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-bazel-bthost"
},
"createdBy": "project:pigweed",
"createTime": "2024-06-19T17:55:28.124526866Z",
"startTime": "2024-06-19T19:57:50.566001913Z",
"endTime": "2024-06-19T20:01:59.736242168Z",
"updateTime": "2024-06-19T20:01:59.736242168Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "e6c5165547f305416c6d11b1a911e912f2aecb6b",
"ref": "refs/heads/main"
}
}
}
[20:01:59.995] Invocation finished in 2h6m33.105330218s with status SUCCEEDED