[18:33:02.238] New invocation is queued and will start shortly
[18:33:03.436] Starting the invocation (attempt 1)
[18:33:03.479] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/f0e734cd30db752e401e76316b4e08b6a9b1abab"
[18:33:03.479] Popped gitiles commit info from properties and tags
[18:33:03.479] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:03.479] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:03.480] Buildbucket request:
{
"requestId": "8992642134169521216",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "ninja-linux-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja",
"revision": "d2dae79908e890222d4fd4fa81c669c40f102c47"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/refs/heads/main@d2dae79908e890222d4fd4fa81c669c40f102c47",
"title": "d2dae79908e890222d4fd4fa81c669c40f102c47",
"url": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/d2dae79908e890222d4fd4fa81c669c40f102c47"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja",
"revision": "04c410b15b70fb321928ffba19d697db15cb0121"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/refs/heads/main@04c410b15b70fb321928ffba19d697db15cb0121",
"title": "04c410b15b70fb321928ffba19d697db15cb0121",
"url": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/04c410b15b70fb321928ffba19d697db15cb0121"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja",
"revision": "f0e734cd30db752e401e76316b4e08b6a9b1abab"
},
"id": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/refs/heads/main@f0e734cd30db752e401e76316b4e08b6a9b1abab",
"title": "f0e734cd30db752e401e76316b4e08b6a9b1abab",
"url": "https://fuchsia.googlesource.com/third_party/github.com/ninja-build/ninja/+/f0e734cd30db752e401e76316b4e08b6a9b1abab"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/github.com/ninja-build/ninja",
"id": "f0e734cd30db752e401e76316b4e08b6a9b1abab",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8992642134169521216"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/ci-ninja-linux-arm64-0c7403b2"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:33:03.932] Scheduled build:
{
"id": "8827212072130341537",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "ninja-linux-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2021-12-21T18:33:03.546960685Z",
"updateTime": "2021-12-21T18:33:03.546960685Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/github.com/ninja-build/ninja",
"id": "f0e734cd30db752e401e76316b4e08b6a9b1abab",
"ref": "refs/heads/main"
}
}
}
[18:33:03.932] Task URL: https://cr-buildbucket.appspot.com/build/8827212072130341537
[18:33:03.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:2:0) after 4m59s
[18:38:03.419] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:2:0)
[18:38:03.454] Build status: SCHEDULED
[18:38:03.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:3:0) after 2m29s
[18:40:32.472] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:3:0)
[18:40:32.514] Build status: SCHEDULED
[18:40:32.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:4:0) after 1m47s
[18:42:19.529] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:4:0)
[18:42:19.563] Build status: SCHEDULED
[18:42:19.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:5:0) after 2m17s
[18:44:36.590] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:5:0)
[18:44:36.622] Build status: SCHEDULED
[18:44:36.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:6:0) after 5m6s
[18:49:42.737] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:6:0)
[18:49:42.775] Build status: SCHEDULED
[18:49:42.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:7:0) after 3m5s
[18:52:47.882] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:7:0)
[18:52:47.911] Build status: SCHEDULED
[18:52:47.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:8:0) after 2m5s
[18:54:52.928] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:8:0)
[18:54:52.978] Build status: SCHEDULED
[18:54:52.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:9:0) after 4m14s
[18:59:07.122] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:9:0)
[18:59:07.165] Build status: SCHEDULED
[18:59:07.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:10:0) after 1m50s
[19:00:57.308] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:10:0)
[19:00:57.406] Build status: SCHEDULED
[19:00:57.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:11:0) after 2m9s
[19:03:06.428] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:11:0)
[19:03:06.456] Build status: SCHEDULED
[19:03:06.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:12:0) after 1m54s
[19:05:00.737] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:12:0)
[19:05:00.766] Build status: SCHEDULED
[19:05:00.766] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:13:0) after 4m19s
[19:09:20.594] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:13:0)
[19:09:20.623] Build status: SCHEDULED
[19:09:20.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:14:0) after 5m5s
[19:14:25.680] Handling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:14:0)
[19:14:25.708] Build status: SCHEDULED
[19:14:25.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/ci-ninja-linux-arm64-0c7403b2:8992642134169521216:15:0) after 4m25s
[19:14:52.790] Received PubSub notification, asking Buildbucket for the build status
[19:14:52.885] Build status: STARTED
[19:16:00.192] Received PubSub notification, asking Buildbucket for the build status
[19:16:00.221] Build:
{
"id": "8827212072130341537",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "ninja-linux-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2021-12-21T18:33:03.546960685Z",
"startTime": "2021-12-21T19:14:51.568852Z",
"endTime": "2021-12-21T19:15:59.934155477Z",
"updateTime": "2021-12-21T19:15:59.934155477Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/github.com/ninja-build/ninja",
"id": "f0e734cd30db752e401e76316b4e08b6a9b1abab",
"ref": "refs/heads/main"
}
}
}
[19:16:00.221] Invocation finished in 42m58.00358113s with status SUCCEEDED