[00:54:15.254] New invocation is queued and will start shortly
[00:54:16.363] Starting the invocation (attempt 1)
[00:54:16.396] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/362fe9d9a87cd8428c86c0058a252d007a874485"
[00:54:16.396] Popped gitiles commit info from properties and tags
[00:54:16.396] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:54:16.398] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:54:16.399] Buildbucket request:
{
"requestId": "8907004016818505952",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-main"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907004016818505952",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-gn-main",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "4b5da9dcb374194f79df0df6ef0320b2ff400375"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@4b5da9dcb374194f79df0df6ef0320b2ff400375",
"title": "4b5da9dcb374194f79df0df6ef0320b2ff400375",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/4b5da9dcb374194f79df0df6ef0320b2ff400375"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "c67d79552acb924db85fcf25a11509f66e570806"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@c67d79552acb924db85fcf25a11509f66e570806",
"title": "c67d79552acb924db85fcf25a11509f66e570806",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/c67d79552acb924db85fcf25a11509f66e570806"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "4224d6d0c23cfd4a19b94b14d76ecb85619a4cf1"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@4224d6d0c23cfd4a19b94b14d76ecb85619a4cf1",
"title": "4224d6d0c23cfd4a19b94b14d76ecb85619a4cf1",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/4224d6d0c23cfd4a19b94b14d76ecb85619a4cf1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "362fe9d9a87cd8428c86c0058a252d007a874485"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@362fe9d9a87cd8428c86c0058a252d007a874485",
"title": "362fe9d9a87cd8428c86c0058a252d007a874485",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/362fe9d9a87cd8428c86c0058a252d007a874485"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "362fe9d9a87cd8428c86c0058a252d007a874485",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907004016818505952"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-gn-main"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:54:16.808] Scheduled build:
{
"id": "8741573954895375425",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-main"
},
"createdBy": "project:pigweed",
"createTime": "2024-07-24T00:54:16.458708510Z",
"updateTime": "2024-07-24T00:54:16.458708510Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "362fe9d9a87cd8428c86c0058a252d007a874485",
"ref": "refs/heads/main"
}
}
}
[00:54:16.808] Task URL: https://cr-buildbucket.appspot.com/build/8741573954895375425
[00:54:16.808] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:2:0) after 6m29s
[00:54:17.868] Received PubSub notification, asking Buildbucket for the build status
[00:54:17.885] Build status: SCHEDULED
[01:00:45.880] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:2:0)
[01:00:45.908] Build status: SCHEDULED
[01:00:45.908] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:4:0) after 9m24s
[01:10:10.024] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:4:0)
[01:10:10.051] Build status: SCHEDULED
[01:10:10.051] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:5:0) after 2m46s
[01:12:56.073] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:5:0)
[01:12:56.095] Build status: SCHEDULED
[01:12:56.095] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:6:0) after 2m13s
[01:15:09.123] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:6:0)
[01:15:09.143] Build status: SCHEDULED
[01:15:09.143] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:7:0) after 3m22s
[01:18:31.161] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:7:0)
[01:18:31.185] Build status: SCHEDULED
[01:18:31.185] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:8:0) after 5m48s
[01:24:19.211] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:8:0)
[01:24:19.231] Build status: SCHEDULED
[01:24:19.231] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:9:0) after 2m12s
[01:26:31.252] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:9:0)
[01:26:31.431] Build status: SCHEDULED
[01:26:31.431] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:10:0) after 6m2s
[01:32:33.492] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:10:0)
[01:32:33.519] Build status: SCHEDULED
[01:32:33.519] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:11:0) after 2m18s
[01:34:51.636] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:11:0)
[01:34:51.664] Build status: SCHEDULED
[01:34:51.664] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:12:0) after 3m29s
[01:38:20.680] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:12:0)
[01:38:20.709] Build status: SCHEDULED
[01:38:20.709] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:13:0) after 3m24s
[01:41:44.866] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:13:0)
[01:41:44.885] Build status: SCHEDULED
[01:41:44.885] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:14:0) after 3m43s
[01:45:27.985] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:14:0)
[01:45:28.003] Build status: SCHEDULED
[01:45:28.003] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:15:0) after 8m13s
[01:53:41.031] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:15:0)
[01:53:41.068] Build status: SCHEDULED
[01:53:41.068] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:16:0) after 1m5s
[01:54:46.106] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:16:0)
[01:54:46.124] Build status: SCHEDULED
[01:54:46.124] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:17:0) after 6m11s
[02:00:57.146] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:17:0)
[02:00:57.172] Build status: SCHEDULED
[02:00:57.172] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:18:0) after 5m18s
[02:06:15.297] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:18:0)
[02:06:15.317] Build status: SCHEDULED
[02:06:15.317] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:19:0) after 6m55s
[02:13:10.598] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:19:0)
[02:13:10.629] Build status: SCHEDULED
[02:13:10.629] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:20:0) after 2m41s
[02:15:51.645] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:20:0)
[02:15:51.664] Build status: SCHEDULED
[02:15:51.664] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:21:0) after 6m33s
[02:22:24.991] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:21:0)
[02:22:25.024] Build status: SCHEDULED
[02:22:25.024] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:22:0) after 4m4s
[02:26:29.300] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:22:0)
[02:26:29.375] Build status: SCHEDULED
[02:26:29.375] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:23:0) after 8m44s
[02:35:13.435] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:23:0)
[02:35:13.453] Build status: SCHEDULED
[02:35:13.453] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:24:0) after 4m24s
[02:39:37.453] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:24:0)
[02:39:37.474] Build status: SCHEDULED
[02:39:37.474] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:25:0) after 1m58s
[02:41:35.496] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:25:0)
[02:41:35.517] Build status: SCHEDULED
[02:41:35.517] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:26:0) after 5m21s
[02:46:56.514] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:26:0)
[02:46:56.533] Build status: SCHEDULED
[02:46:56.533] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:27:0) after 7m5s
[02:54:01.552] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:27:0)
[02:54:01.571] Build status: SCHEDULED
[02:54:01.571] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:28:0) after 2m15s
[02:56:16.590] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:28:0)
[02:56:16.615] Build status: SCHEDULED
[02:56:16.615] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:29:0) after 3m31s
[02:57:53.665] Received PubSub notification, asking Buildbucket for the build status
[02:57:53.700] Build status: STARTED
[02:59:47.690] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:29:0)
[02:59:47.715] Build status: STARTED
[02:59:47.715] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:31:0) after 7m5s
[03:06:52.805] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:31:0)
[03:06:52.830] Build status: STARTED
[03:06:52.830] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:32:0) after 7m29s
[03:14:21.822] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:32:0)
[03:14:21.844] Build status: STARTED
[03:14:21.844] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:33:0) after 7m57s
[03:22:18.874] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:33:0)
[03:22:18.892] Build status: STARTED
[03:22:18.892] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:34:0) after 4m6s
[03:26:24.914] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:34:0)
[03:26:24.934] Build status: STARTED
[03:26:24.934] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-gn-main:8907004016818505952:35:0) after 8m39s
[03:28:46.166] Received PubSub notification, asking Buildbucket for the build status
[03:28:46.189] Build:
{
"id": "8741573954895375425",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-gn-main"
},
"createdBy": "project:pigweed",
"createTime": "2024-07-24T00:54:16.458708510Z",
"startTime": "2024-07-24T02:57:53.182247296Z",
"endTime": "2024-07-24T03:28:45.903637035Z",
"updateTime": "2024-07-24T03:28:45.903637035Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "362fe9d9a87cd8428c86c0058a252d007a874485",
"ref": "refs/heads/main"
}
}
}
[03:28:46.189] Invocation finished in 2h34m30.949370417s with status SUCCEEDED