[19:07:14.554] New invocation is queued and will start shortly
[19:07:16.261] Starting the invocation (attempt 1)
[19:07:16.286] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/48529a4bb6513469d479af6564f5f8a152c4aaf7"
[19:07:16.286] Popped gitiles commit info from properties and tags
[19:07:16.286] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:07:16.286] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:07:16.287] Buildbucket request:
{
"requestId": "8853573638724198560",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-old"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8853573638724198560",
"job": "r8/linux-old",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "68967c9be3966ab4f3f74d7c38a60dab93a389ee"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@68967c9be3966ab4f3f74d7c38a60dab93a389ee",
"title": "68967c9be3966ab4f3f74d7c38a60dab93a389ee",
"url": "https://r8.googlesource.com/r8/+/68967c9be3966ab4f3f74d7c38a60dab93a389ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "aa235dc455774971635d2f110d82370a6fbc1539"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@aa235dc455774971635d2f110d82370a6fbc1539",
"title": "aa235dc455774971635d2f110d82370a6fbc1539",
"url": "https://r8.googlesource.com/r8/+/aa235dc455774971635d2f110d82370a6fbc1539"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "e0d0bb87f5b792f343698aff1ab886ab9320deb0"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@e0d0bb87f5b792f343698aff1ab886ab9320deb0",
"title": "e0d0bb87f5b792f343698aff1ab886ab9320deb0",
"url": "https://r8.googlesource.com/r8/+/e0d0bb87f5b792f343698aff1ab886ab9320deb0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "555aa3b867f491fe99951f07c7048daabb8912b7"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@555aa3b867f491fe99951f07c7048daabb8912b7",
"title": "555aa3b867f491fe99951f07c7048daabb8912b7",
"url": "https://r8.googlesource.com/r8/+/555aa3b867f491fe99951f07c7048daabb8912b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "4d42ae7dca42c8a26db59d3009324ca697b9823e"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@4d42ae7dca42c8a26db59d3009324ca697b9823e",
"title": "4d42ae7dca42c8a26db59d3009324ca697b9823e",
"url": "https://r8.googlesource.com/r8/+/4d42ae7dca42c8a26db59d3009324ca697b9823e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "36c5cd1aa47da1ae8bdae21fcc6072f3a22a5a09"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@36c5cd1aa47da1ae8bdae21fcc6072f3a22a5a09",
"title": "36c5cd1aa47da1ae8bdae21fcc6072f3a22a5a09",
"url": "https://r8.googlesource.com/r8/+/36c5cd1aa47da1ae8bdae21fcc6072f3a22a5a09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "71463498f29c28e928e6d700c9a25faeba0996ff"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@71463498f29c28e928e6d700c9a25faeba0996ff",
"title": "71463498f29c28e928e6d700c9a25faeba0996ff",
"url": "https://r8.googlesource.com/r8/+/71463498f29c28e928e6d700c9a25faeba0996ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "4ebfa384241001d599cc1631d735f0092bc1b91b"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@4ebfa384241001d599cc1631d735f0092bc1b91b",
"title": "4ebfa384241001d599cc1631d735f0092bc1b91b",
"url": "https://r8.googlesource.com/r8/+/4ebfa384241001d599cc1631d735f0092bc1b91b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "075e6fe1b30603eec0b89178a8925fe969802c38"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@075e6fe1b30603eec0b89178a8925fe969802c38",
"title": "075e6fe1b30603eec0b89178a8925fe969802c38",
"url": "https://r8.googlesource.com/r8/+/075e6fe1b30603eec0b89178a8925fe969802c38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "44fdc37141d4327725da494c36f03f573f51a9e7"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@44fdc37141d4327725da494c36f03f573f51a9e7",
"title": "44fdc37141d4327725da494c36f03f573f51a9e7",
"url": "https://r8.googlesource.com/r8/+/44fdc37141d4327725da494c36f03f573f51a9e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "8567856344d05ad68de3769842a2ddbfea8505ca"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@8567856344d05ad68de3769842a2ddbfea8505ca",
"title": "8567856344d05ad68de3769842a2ddbfea8505ca",
"url": "https://r8.googlesource.com/r8/+/8567856344d05ad68de3769842a2ddbfea8505ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "48529a4bb6513469d479af6564f5f8a152c4aaf7"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@48529a4bb6513469d479af6564f5f8a152c4aaf7",
"title": "48529a4bb6513469d479af6564f5f8a152c4aaf7",
"url": "https://r8.googlesource.com/r8/+/48529a4bb6513469d479af6564f5f8a152c4aaf7"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "48529a4bb6513469d479af6564f5f8a152c4aaf7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8853573638724198560"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-old"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:07:16.886] Scheduled build:
{
"id": "8688143576198502977",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-old"
},
"number": 980,
"createdBy": "project:r8",
"createTime": "2026-03-05T19:07:16.337404728Z",
"updateTime": "2026-03-05T19:07:16.337404728Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "48529a4bb6513469d479af6564f5f8a152c4aaf7",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:07:16.886] Task URL: https://cr-buildbucket.appspot.com/build/8688143576198502977
[19:07:16.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:2:0) after 7m17s
[19:07:17.800] Received PubSub notification, asking Buildbucket for the build status
[19:07:17.816] Build status: SCHEDULED
[19:14:33.913] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:2:0)
[19:14:33.930] Build status: SCHEDULED
[19:14:33.930] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:4:0) after 8m11s
[19:22:44.946] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:4:0)
[19:22:44.969] Build status: SCHEDULED
[19:22:44.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:5:0) after 7m10s
[19:29:55.016] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:5:0)
[19:29:55.037] Build status: SCHEDULED
[19:29:55.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:6:0) after 1m20s
[19:31:15.072] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:6:0)
[19:31:15.095] Build status: SCHEDULED
[19:31:15.095] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:7:0) after 4m14s
[19:35:29.113] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:7:0)
[19:35:29.142] Build status: SCHEDULED
[19:35:29.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:8:0) after 4m39s
[19:40:08.206] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:8:0)
[19:40:08.221] Build status: SCHEDULED
[19:40:08.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:9:0) after 5m36s
[19:45:44.238] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:9:0)
[19:45:44.254] Build status: SCHEDULED
[19:45:44.255] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:10:0) after 3m34s
[19:48:31.385] Received PubSub notification, asking Buildbucket for the build status
[19:48:31.601] Build status: STARTED
[19:49:18.297] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:10:0)
[19:49:18.314] Build status: STARTED
[19:49:18.314] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:12:0) after 1m44s
[19:51:02.328] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:12:0)
[19:51:02.384] Build status: STARTED
[19:51:02.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:13:0) after 9m53s
[20:00:55.414] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:13:0)
[20:00:55.450] Build status: STARTED
[20:00:55.450] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:14:0) after 9m53s
[20:10:48.526] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:14:0)
[20:10:48.541] Build status: STARTED
[20:10:48.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:15:0) after 9m44s
[20:20:32.563] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:15:0)
[20:20:32.581] Build status: STARTED
[20:20:32.581] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:16:0) after 9m51s
[20:30:23.597] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:16:0)
[20:30:23.619] Build status: STARTED
[20:30:23.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:17:0) after 2m42s
[20:33:05.740] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:17:0)
[20:33:05.753] Build status: STARTED
[20:33:05.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:18:0) after 9m56s
[20:43:01.851] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:18:0)
[20:43:01.866] Build status: STARTED
[20:43:01.866] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:19:0) after 4m49s
[20:47:50.973] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:19:0)
[20:47:50.991] Build status: STARTED
[20:47:50.991] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:20:0) after 7m55s
[20:55:45.961] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:20:0)
[20:55:45.982] Build status: STARTED
[20:55:45.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:21:0) after 6m23s
[21:02:08.997] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:21:0)
[21:02:09.012] Build status: STARTED
[21:02:09.012] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:22:0) after 4m49s
[21:06:57.998] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:22:0)
[21:06:58.067] Build status: STARTED
[21:06:58.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:23:0) after 3m9s
[21:10:07.127] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:23:0)
[21:10:07.146] Build status: STARTED
[21:10:07.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:24:0) after 3m35s
[21:13:42.165] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:24:0)
[21:13:42.192] Build status: STARTED
[21:13:42.192] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:25:0) after 4m55s
[21:18:37.394] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:25:0)
[21:18:37.409] Build status: STARTED
[21:18:37.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:26:0) after 8m39s
[21:27:16.380] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:26:0)
[21:27:16.407] Build status: STARTED
[21:27:16.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:27:0) after 5m54s
[21:33:10.523] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:27:0)
[21:33:10.551] Build status: STARTED
[21:33:10.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:28:0) after 2m14s
[21:35:24.619] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:28:0)
[21:35:24.635] Build status: STARTED
[21:35:24.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:29:0) after 4m40s
[21:40:04.638] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:29:0)
[21:40:04.662] Build status: STARTED
[21:40:04.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:30:0) after 4m36s
[21:44:40.800] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:30:0)
[21:44:40.823] Build status: STARTED
[21:44:40.823] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:31:0) after 5m38s
[21:50:18.849] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:31:0)
[21:50:18.863] Build status: STARTED
[21:50:18.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:32:0) after 3m31s
[21:53:49.982] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:32:0)
[21:53:49.999] Build status: STARTED
[21:53:49.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:33:0) after 6m17s
[22:00:07.034] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:33:0)
[22:00:07.062] Build status: STARTED
[22:00:07.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:34:0) after 3m52s
[22:03:59.098] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:34:0)
[22:03:59.128] Build status: STARTED
[22:03:59.129] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:35:0) after 4m50s
[22:08:49.274] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:35:0)
[22:08:49.292] Build status: STARTED
[22:08:49.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:36:0) after 4m44s
[22:13:33.309] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:36:0)
[22:13:33.328] Build status: STARTED
[22:13:33.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:37:0) after 8m19s
[22:21:52.344] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:37:0)
[22:21:52.362] Build status: STARTED
[22:21:52.362] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:38:0) after 2m30s
[22:24:22.378] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:38:0)
[22:24:22.418] Build status: STARTED
[22:24:22.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:39:0) after 4m29s
[22:28:51.390] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:39:0)
[22:28:51.406] Build status: STARTED
[22:28:51.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:40:0) after 5m58s
[22:34:49.422] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:40:0)
[22:34:49.436] Build status: STARTED
[22:34:49.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:41:0) after 1m53s
[22:36:42.553] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:41:0)
[22:36:42.568] Build status: STARTED
[22:36:42.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:42:0) after 3m24s
[22:40:06.581] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:42:0)
[22:40:06.607] Build status: STARTED
[22:40:06.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:43:0) after 6m10s
[22:46:16.666] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:43:0)
[22:46:16.697] Build status: STARTED
[22:46:16.698] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:44:0) after 8m14s
[22:54:30.724] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:44:0)
[22:54:30.739] Build status: STARTED
[22:54:30.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:45:0) after 4m5s
[22:58:35.748] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:45:0)
[22:58:35.770] Build status: STARTED
[22:58:35.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:46:0) after 5m7s
[23:03:42.785] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:46:0)
[23:03:42.818] Build status: STARTED
[23:03:42.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:47:0) after 1m48s
[23:05:30.896] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:47:0)
[23:05:31.033] Build status: STARTED
[23:05:31.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:48:0) after 9m1s
[23:14:32.146] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:48:0)
[23:14:32.164] Build status: STARTED
[23:14:32.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:49:0) after 7m46s
[23:22:18.182] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:49:0)
[23:22:18.231] Build status: STARTED
[23:22:18.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:50:0) after 1m15s
[23:23:33.247] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:50:0)
[23:23:33.300] Build status: STARTED
[23:23:33.300] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:51:0) after 6m11s
[23:29:44.314] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:51:0)
[23:29:44.353] Build status: STARTED
[23:29:44.353] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:52:0) after 9m28s
[23:39:12.367] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:52:0)
[23:39:12.381] Build status: STARTED
[23:39:12.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:53:0) after 4m14s
[23:43:26.495] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:53:0)
[23:43:26.593] Build status: STARTED
[23:43:26.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:54:0) after 5m57s
[23:49:23.601] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:54:0)
[23:49:23.617] Build status: STARTED
[23:49:23.617] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:55:0) after 3m48s
[23:53:11.587] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:55:0)
[23:53:11.611] Build status: STARTED
[23:53:11.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:56:0) after 5m22s
[23:58:33.639] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:56:0)
[23:58:33.670] Build status: STARTED
[23:58:33.670] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:57:0) after 3m17s
[00:01:50.805] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:57:0)
[00:01:50.835] Build status: STARTED
[00:01:50.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:58:0) after 5m2s
[00:06:52.854] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:58:0)
[00:06:52.880] Build status: STARTED
[00:06:52.880] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:59:0) after 3m9s
[00:10:02.047] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:59:0)
[00:10:02.081] Build status: STARTED
[00:10:02.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:60:0) after 2m33s
[00:12:35.123] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:60:0)
[00:12:35.141] Build status: STARTED
[00:12:35.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:61:0) after 7m3s
[00:19:38.277] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:61:0)
[00:19:38.299] Build status: STARTED
[00:19:38.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:62:0) after 5m32s
[00:25:10.419] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:62:0)
[00:25:10.435] Build status: STARTED
[00:25:10.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:63:0) after 5m22s
[00:30:32.448] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:63:0)
[00:30:32.495] Build status: STARTED
[00:30:32.495] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:64:0) after 2m58s
[00:33:30.562] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:64:0)
[00:33:30.653] Build status: STARTED
[00:33:30.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:65:0) after 3m45s
[00:37:15.673] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:65:0)
[00:37:15.696] Build status: STARTED
[00:37:15.696] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:66:0) after 6m59s
[00:44:14.806] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:66:0)
[00:44:14.827] Build status: STARTED
[00:44:14.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:67:0) after 6m25s
[00:50:39.797] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:67:0)
[00:50:39.810] Build status: STARTED
[00:50:39.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:68:0) after 7m2s
[00:57:41.828] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:68:0)
[00:57:41.845] Build status: STARTED
[00:57:41.845] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:69:0) after 1m8s
[00:58:49.859] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:69:0)
[00:58:49.887] Build status: STARTED
[00:58:49.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:70:0) after 1m10s
[00:59:59.954] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:70:0)
[00:59:59.972] Build status: STARTED
[00:59:59.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:71:0) after 3m6s
[01:03:06.174] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:71:0)
[01:03:06.219] Build status: STARTED
[01:03:06.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:72:0) after 1m33s
[01:04:39.282] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:72:0)
[01:04:39.450] Build status: STARTED
[01:04:39.450] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:73:0) after 7m53s
[01:12:32.578] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:73:0)
[01:12:32.598] Build status: STARTED
[01:12:32.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:74:0) after 6m9s
[01:18:41.838] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:74:0)
[01:18:41.872] Build status: STARTED
[01:18:41.872] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:75:0) after 3m41s
[01:22:22.889] Handling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:75:0)
[01:22:22.910] Build status: STARTED
[01:22:22.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-old:8853573638724198560:76:0) after 7m19s
[01:25:36.015] Received PubSub notification, asking Buildbucket for the build status
[01:25:36.047] Build:
{
"id": "8688143576198502977",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-old"
},
"number": 980,
"createdBy": "project:r8",
"createTime": "2026-03-05T19:07:16.337404728Z",
"startTime": "2026-03-05T19:48:31.221271078Z",
"endTime": "2026-03-06T01:25:35.686036324Z",
"updateTime": "2026-03-06T01:25:35.686036324Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "48529a4bb6513469d479af6564f5f8a152c4aaf7",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:25:36.047] Invocation finished in 6h18m21.501671557s with status SUCCEEDED