[17:21:00.343] New invocation is queued and will start shortly
[17:21:01.412] Starting the invocation (attempt 1)
[17:21:01.445] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/b83d27482bb6ccf7ad78632ade08d207a656b34f"
[17:21:01.446] Popped gitiles commit info from properties and tags
[17:21:01.446] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:21:01.446] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:21:01.446] Buildbucket request:
{
"requestId": "8905673578246133872",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905673578246133872",
"job": "pigweed/pigweed.dev.ci-pigweed-lintformat-full",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "c5a66b2e447524ffd3de9bc84d02d26245746b35"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@c5a66b2e447524ffd3de9bc84d02d26245746b35",
"title": "c5a66b2e447524ffd3de9bc84d02d26245746b35",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/c5a66b2e447524ffd3de9bc84d02d26245746b35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "59eb77108667b32b2a18aa099e46e710592e6b3a"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@59eb77108667b32b2a18aa099e46e710592e6b3a",
"title": "59eb77108667b32b2a18aa099e46e710592e6b3a",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/59eb77108667b32b2a18aa099e46e710592e6b3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "700cfaf609aa933817629aab90d4acd1b625f32e"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@700cfaf609aa933817629aab90d4acd1b625f32e",
"title": "700cfaf609aa933817629aab90d4acd1b625f32e",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/700cfaf609aa933817629aab90d4acd1b625f32e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "0fe4fa324363134d1004d369497b9581b74f7b1f"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@0fe4fa324363134d1004d369497b9581b74f7b1f",
"title": "0fe4fa324363134d1004d369497b9581b74f7b1f",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/0fe4fa324363134d1004d369497b9581b74f7b1f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "b83d27482bb6ccf7ad78632ade08d207a656b34f"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@b83d27482bb6ccf7ad78632ade08d207a656b34f",
"title": "b83d27482bb6ccf7ad78632ade08d207a656b34f",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/b83d27482bb6ccf7ad78632ade08d207a656b34f"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b83d27482bb6ccf7ad78632ade08d207a656b34f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905673578246133872"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-lintformat-full"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:21:02.268] Scheduled build:
{
"id": "8740243516363831857",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"createdBy": "project:pigweed",
"createTime": "2024-08-07T17:21:01.515379656Z",
"updateTime": "2024-08-07T17:21:01.515379656Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b83d27482bb6ccf7ad78632ade08d207a656b34f",
"ref": "refs/heads/main"
}
}
}
[17:21:02.268] Task URL: https://cr-buildbucket.appspot.com/build/8740243516363831857
[17:21:02.268] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:2:0) after 1m21s
[17:21:02.848] Received PubSub notification, asking Buildbucket for the build status
[17:21:02.868] Build status: SCHEDULED
[17:22:23.293] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:2:0)
[17:22:23.319] Build status: SCHEDULED
[17:22:23.320] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:4:0) after 1m42s
[17:24:05.342] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:4:0)
[17:24:05.372] Build status: SCHEDULED
[17:24:05.372] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:5:0) after 7m25s
[17:31:30.493] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:5:0)
[17:31:30.513] Build status: SCHEDULED
[17:31:30.513] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:6:0) after 8m12s
[17:39:42.577] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:6:0)
[17:39:42.617] Build status: SCHEDULED
[17:39:42.617] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:7:0) after 1m51s
[17:41:33.632] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:7:0)
[17:41:33.710] Build status: SCHEDULED
[17:41:33.710] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:8:0) after 5m36s
[17:47:09.723] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:8:0)
[17:47:09.745] Build status: SCHEDULED
[17:47:09.745] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:9:0) after 4m52s
[17:52:01.810] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:9:0)
[17:52:01.847] Build status: SCHEDULED
[17:52:01.847] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:10:0) after 9m10s
[18:01:11.913] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:10:0)
[18:01:11.931] Build status: SCHEDULED
[18:01:11.931] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:11:0) after 6m19s
[18:07:30.906] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:11:0)
[18:07:30.925] Build status: SCHEDULED
[18:07:30.925] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:12:0) after 6m50s
[18:14:20.938] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:12:0)
[18:14:20.959] Build status: SCHEDULED
[18:14:20.959] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:13:0) after 5m57s
[18:20:18.058] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:13:0)
[18:20:18.077] Build status: SCHEDULED
[18:20:18.077] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:14:0) after 4m6s
[18:24:24.118] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:14:0)
[18:24:24.140] Build status: SCHEDULED
[18:24:24.141] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:15:0) after 1m54s
[18:26:18.201] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:15:0)
[18:26:18.236] Build status: SCHEDULED
[18:26:18.236] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:16:0) after 4m51s
[18:31:09.281] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:16:0)
[18:31:09.301] Build status: SCHEDULED
[18:31:09.301] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:17:0) after 2m24s
[18:33:33.435] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:17:0)
[18:33:33.462] Build status: SCHEDULED
[18:33:33.462] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:18:0) after 8m12s
[18:41:45.479] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:18:0)
[18:41:45.590] Build status: SCHEDULED
[18:41:45.590] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:19:0) after 5m4s
[18:46:49.698] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:19:0)
[18:46:49.720] Build status: SCHEDULED
[18:46:49.721] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:20:0) after 6m34s
[18:53:23.747] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:20:0)
[18:53:23.763] Build status: SCHEDULED
[18:53:23.763] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:21:0) after 4m24s
[18:57:47.766] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:21:0)
[18:57:47.799] Build status: SCHEDULED
[18:57:47.799] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:22:0) after 8m46s
[19:06:33.825] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:22:0)
[19:06:33.855] Build status: SCHEDULED
[19:06:33.855] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:23:0) after 9m43s
[19:16:16.881] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:23:0)
[19:16:16.901] Build status: SCHEDULED
[19:16:16.901] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:24:0) after 3m51s
[19:20:08.018] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:24:0)
[19:20:08.036] Build status: SCHEDULED
[19:20:08.036] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:25:0) after 1m7s
[19:21:15.069] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:25:0)
[19:21:15.104] Build status: SCHEDULED
[19:21:15.104] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:26:0) after 1m20s
[19:22:35.182] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:26:0)
[19:22:35.199] Build status: SCHEDULED
[19:22:35.199] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:27:0) after 2m25s
[19:25:00.266] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:27:0)
[19:25:00.287] Build status: SCHEDULED
[19:25:00.287] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:28:0) after 8m49s
[19:33:49.307] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:28:0)
[19:33:49.326] Build status: SCHEDULED
[19:33:49.326] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:29:0) after 3m6s
[19:36:55.350] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:29:0)
[19:36:55.403] Build status: SCHEDULED
[19:36:55.403] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:30:0) after 1m25s
[19:38:20.444] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:30:0)
[19:38:20.462] Build status: SCHEDULED
[19:38:20.462] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:31:0) after 6m56s
[19:41:37.546] Received PubSub notification, asking Buildbucket for the build status
[19:41:37.566] Build status: STARTED
[19:45:16.460] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:31:0)
[19:45:16.485] Build status: STARTED
[19:45:16.485] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:33:0) after 2m43s
[19:47:59.507] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:33:0)
[19:47:59.559] Build status: STARTED
[19:47:59.559] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:34:0) after 7m3s
[19:55:02.581] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:34:0)
[19:55:02.600] Build status: STARTED
[19:55:02.600] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-lintformat-full:8905673578246133872:35:0) after 6m42s
[19:55:52.718] Received PubSub notification, asking Buildbucket for the build status
[19:55:52.740] Build:
{
"id": "8740243516363831857",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-lintformat-full"
},
"createdBy": "project:pigweed",
"createTime": "2024-08-07T17:21:01.515379656Z",
"startTime": "2024-08-07T19:40:35.342329628Z",
"endTime": "2024-08-07T19:55:52.268432869Z",
"updateTime": "2024-08-07T19:55:52.268432869Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "b83d27482bb6ccf7ad78632ade08d207a656b34f",
"ref": "refs/heads/main"
}
}
}
[19:55:52.740] Invocation finished in 2h34m52.403428918s with status SUCCEEDED