[22:40:00.445] New invocation is queued and will start shortly
[22:40:01.800] Starting the invocation (attempt 1)
[22:40:01.830] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/pigweed/+/662d5e89ab39572e18364a5222b777c2b56712cb"
[22:40:01.830] Popped gitiles commit info from properties and tags
[22:40:01.830] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:40:01.830] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:40:01.830] Buildbucket request:
{
"requestId": "8882641878932185632",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-static-analysis"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882641878932185632",
"job": "pigweed/pigweed.dev.ci-pigweed-linux-static-analysis",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "2866b2a42434b11df670ae07276a2a1a9db97034"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@2866b2a42434b11df670ae07276a2a1a9db97034",
"title": "2866b2a42434b11df670ae07276a2a1a9db97034",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/2866b2a42434b11df670ae07276a2a1a9db97034"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "e7934a3d63c76995cd0ec3db55684e1dcfd5867a"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@e7934a3d63c76995cd0ec3db55684e1dcfd5867a",
"title": "e7934a3d63c76995cd0ec3db55684e1dcfd5867a",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/e7934a3d63c76995cd0ec3db55684e1dcfd5867a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "e5b0af276d693f2f3bcabc88b58810aec1c18a67"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@e5b0af276d693f2f3bcabc88b58810aec1c18a67",
"title": "e5b0af276d693f2f3bcabc88b58810aec1c18a67",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/e5b0af276d693f2f3bcabc88b58810aec1c18a67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "222ad327c9df8dd59fb3a0fc2c6058f38c985904"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@222ad327c9df8dd59fb3a0fc2c6058f38c985904",
"title": "222ad327c9df8dd59fb3a0fc2c6058f38c985904",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/222ad327c9df8dd59fb3a0fc2c6058f38c985904"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "824ffb391d32eecf7c3c02ae4cebbabecd0d758f"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@824ffb391d32eecf7c3c02ae4cebbabecd0d758f",
"title": "824ffb391d32eecf7c3c02ae4cebbabecd0d758f",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/824ffb391d32eecf7c3c02ae4cebbabecd0d758f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/pigweed",
"revision": "662d5e89ab39572e18364a5222b777c2b56712cb"
},
"id": "https://pigweed.googlesource.com/pigweed/pigweed/+/refs/heads/main@662d5e89ab39572e18364a5222b777c2b56712cb",
"title": "662d5e89ab39572e18364a5222b777c2b56712cb",
"url": "https://pigweed.googlesource.com/pigweed/pigweed/+/662d5e89ab39572e18364a5222b777c2b56712cb"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "662d5e89ab39572e18364a5222b777c2b56712cb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882641878932185632"
},
{
"key": "scheduler_job_id",
"value": "pigweed/pigweed.dev.ci-pigweed-linux-static-analysis"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:40:02.197] Scheduled build:
{
"id": "8717211816760123361",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-static-analysis"
},
"createdBy": "project:pigweed",
"createTime": "2025-04-18T22:40:01.890405862Z",
"updateTime": "2025-04-18T22:40:01.890405862Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "662d5e89ab39572e18364a5222b777c2b56712cb",
"ref": "refs/heads/main"
}
}
}
[22:40:02.197] Task URL: https://cr-buildbucket.appspot.com/build/8717211816760123361
[22:40:02.197] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:2:0) after 8m25s
[22:40:02.735] Received PubSub notification, asking Buildbucket for the build status
[22:40:02.773] Build status: SCHEDULED
[22:48:27.217] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:2:0)
[22:48:27.232] Build status: SCHEDULED
[22:48:27.232] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:4:0) after 3m1s
[22:51:28.296] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:4:0)
[22:51:28.332] Build status: SCHEDULED
[22:51:28.332] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:5:0) after 4m40s
[22:56:08.452] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:5:0)
[22:56:08.478] Build status: SCHEDULED
[22:56:08.478] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:6:0) after 8m57s
[23:05:05.554] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:6:0)
[23:05:05.615] Build status: SCHEDULED
[23:05:05.615] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:7:0) after 3m51s
[23:08:56.615] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:7:0)
[23:08:56.640] Build status: SCHEDULED
[23:08:56.641] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:8:0) after 1m59s
[23:10:55.692] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:8:0)
[23:10:55.711] Build status: SCHEDULED
[23:10:55.711] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:9:0) after 3m7s
[23:14:02.730] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:9:0)
[23:14:02.755] Build status: SCHEDULED
[23:14:02.755] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:10:0) after 3m42s
[23:17:44.769] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:10:0)
[23:17:44.797] Build status: SCHEDULED
[23:17:44.797] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:11:0) after 4m58s
[23:22:42.823] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:11:0)
[23:22:42.845] Build status: SCHEDULED
[23:22:42.845] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:12:0) after 1m25s
[23:24:07.867] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:12:0)
[23:24:07.975] Build status: SCHEDULED
[23:24:07.975] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:13:0) after 9m23s
[23:33:30.993] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:13:0)
[23:33:31.020] Build status: SCHEDULED
[23:33:31.020] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:14:0) after 5m12s
[23:38:43.040] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:14:0)
[23:38:43.064] Build status: SCHEDULED
[23:38:43.064] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:15:0) after 4m41s
[23:43:24.095] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:15:0)
[23:43:24.114] Build status: SCHEDULED
[23:43:24.114] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:16:0) after 1m49s
[23:45:13.201] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:16:0)
[23:45:13.226] Build status: SCHEDULED
[23:45:13.226] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:17:0) after 6m53s
[23:52:06.219] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:17:0)
[23:52:06.236] Build status: SCHEDULED
[23:52:06.236] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:18:0) after 9m32s
[00:01:38.323] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:18:0)
[00:01:38.340] Build status: SCHEDULED
[00:01:38.340] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:19:0) after 4m7s
[00:05:45.366] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:19:0)
[00:05:45.392] Build status: SCHEDULED
[00:05:45.392] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:20:0) after 1m18s
[00:07:03.413] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:20:0)
[00:07:03.435] Build status: SCHEDULED
[00:07:03.435] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:21:0) after 2m11s
[00:09:14.504] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:21:0)
[00:09:14.524] Build status: SCHEDULED
[00:09:14.524] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:22:0) after 5m4s
[00:14:18.507] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:22:0)
[00:14:18.534] Build status: SCHEDULED
[00:14:18.534] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:23:0) after 6m20s
[00:20:38.567] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:23:0)
[00:20:38.587] Build status: SCHEDULED
[00:20:38.587] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:24:0) after 3m35s
[00:24:13.705] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:24:0)
[00:24:13.735] Build status: SCHEDULED
[00:24:13.735] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:25:0) after 3m31s
[00:27:44.750] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:25:0)
[00:27:44.775] Build status: SCHEDULED
[00:27:44.775] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:26:0) after 1m58s
[00:29:42.799] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:26:0)
[00:29:42.825] Build status: SCHEDULED
[00:29:42.826] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:27:0) after 2m34s
[00:32:16.844] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:27:0)
[00:32:16.863] Build status: SCHEDULED
[00:32:16.863] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:28:0) after 5m36s
[00:37:52.916] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:28:0)
[00:37:52.937] Build status: SCHEDULED
[00:37:52.937] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:29:0) after 7m6s
[00:44:59.066] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:29:0)
[00:44:59.098] Build status: SCHEDULED
[00:44:59.098] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:30:0) after 7m23s
[00:52:22.156] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:30:0)
[00:52:22.196] Build status: SCHEDULED
[00:52:22.196] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:31:0) after 4m19s
[00:56:41.220] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:31:0)
[00:56:41.289] Build status: SCHEDULED
[00:56:41.289] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:32:0) after 3m55s
[01:00:36.362] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:32:0)
[01:00:36.383] Build status: SCHEDULED
[01:00:36.383] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:33:0) after 5m39s
[01:06:15.405] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:33:0)
[01:06:15.425] Build status: SCHEDULED
[01:06:15.425] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:34:0) after 3m38s
[01:09:53.496] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:34:0)
[01:09:53.512] Build status: SCHEDULED
[01:09:53.512] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:35:0) after 8m54s
[01:18:47.509] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:35:0)
[01:18:47.529] Build status: SCHEDULED
[01:18:47.529] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:36:0) after 7m36s
[01:26:23.549] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:36:0)
[01:26:23.569] Build status: SCHEDULED
[01:26:23.569] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:37:0) after 7m21s
[01:32:22.448] Received PubSub notification, asking Buildbucket for the build status
[01:32:22.478] Build status: STARTED
[01:33:44.584] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:37:0)
[01:33:44.600] Build status: STARTED
[01:33:44.600] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:39:0) after 2m33s
[01:36:17.673] Handling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:39:0)
[01:36:17.688] Build status: STARTED
[01:36:17.688] Scheduling timer "check-buildbucket-build-status" (pigweed/pigweed.dev.ci-pigweed-linux-static-analysis:8882641878932185632:40:0) after 8m13s
[01:41:01.864] Received PubSub notification, asking Buildbucket for the build status
[01:41:01.888] Build:
{
"id": "8717211816760123361",
"builder": {
"project": "pigweed",
"bucket": "pigweed.dev.ci",
"builder": "pigweed-linux-static-analysis"
},
"createdBy": "project:pigweed",
"createTime": "2025-04-18T22:40:01.890405862Z",
"startTime": "2025-04-19T01:32:22.104181202Z",
"endTime": "2025-04-19T01:40:46.638415220Z",
"updateTime": "2025-04-19T01:40:46.638415220Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/pigweed",
"id": "662d5e89ab39572e18364a5222b777c2b56712cb",
"ref": "refs/heads/main"
}
}
}
[01:41:01.888] Invocation finished in 3h1m1.45365855s with status SUCCEEDED