[20:10:29.639] New invocation is queued and will start shortly
[20:10:30.719] Starting the invocation (attempt 1)
[20:10:30.741] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/8ae166610b37bb7e075da9d751459f0823e96958"
[20:10:30.742] Popped gitiles commit info from properties and tags
[20:10:30.742] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:10:30.742] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:10:30.742] Buildbucket request:
{
"requestId": "8847590259502608704",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-android-14"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8847590259502608704",
"job": "r8/linux-android-14",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "a35967babd44334d5a6ec67dc64f9bfde4ddb189"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@a35967babd44334d5a6ec67dc64f9bfde4ddb189",
"title": "a35967babd44334d5a6ec67dc64f9bfde4ddb189",
"url": "https://r8.googlesource.com/r8/+/a35967babd44334d5a6ec67dc64f9bfde4ddb189"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "8ae166610b37bb7e075da9d751459f0823e96958"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@8ae166610b37bb7e075da9d751459f0823e96958",
"title": "8ae166610b37bb7e075da9d751459f0823e96958",
"url": "https://r8.googlesource.com/r8/+/8ae166610b37bb7e075da9d751459f0823e96958"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8ae166610b37bb7e075da9d751459f0823e96958",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8847590259502608704"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-android-14"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:10:31.243] Scheduled build:
{
"id": "8682160197597183745",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-android-14"
},
"number": 1661,
"createdBy": "project:r8",
"createTime": "2026-05-10T20:10:30.834370750Z",
"updateTime": "2026-05-10T20:10:30.834370750Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8ae166610b37bb7e075da9d751459f0823e96958",
"ref": "refs/heads/main"
}
}
}
[20:10:31.243] Task URL: https://cr-buildbucket.appspot.com/build/8682160197597183745
[20:10:31.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:2:0) after 5m36s
[20:10:32.180] Received PubSub notification, asking Buildbucket for the build status
[20:10:32.213] Build status: SCHEDULED
[20:16:07.291] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:2:0)
[20:16:07.312] Build status: SCHEDULED
[20:16:07.312] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:4:0) after 5m36s
[20:21:43.323] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:4:0)
[20:21:43.342] Build status: SCHEDULED
[20:21:43.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:5:0) after 3m33s
[20:25:16.417] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:5:0)
[20:25:16.432] Build status: SCHEDULED
[20:25:16.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:6:0) after 8m30s
[20:33:46.426] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:6:0)
[20:33:46.451] Build status: SCHEDULED
[20:33:46.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:7:0) after 1m5s
[20:34:51.666] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:7:0)
[20:34:51.685] Build status: SCHEDULED
[20:34:51.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:8:0) after 3m26s
[20:38:17.696] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:8:0)
[20:38:17.713] Build status: SCHEDULED
[20:38:17.714] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:9:0) after 6m56s
[20:45:13.825] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:9:0)
[20:45:13.844] Build status: SCHEDULED
[20:45:13.844] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:10:0) after 7m9s
[20:52:22.856] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:10:0)
[20:52:22.881] Build status: SCHEDULED
[20:52:22.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:11:0) after 3m15s
[20:55:37.918] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:11:0)
[20:55:37.936] Build status: SCHEDULED
[20:55:37.936] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:12:0) after 4m29s
[21:00:07.048] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:12:0)
[21:00:07.070] Build status: SCHEDULED
[21:00:07.070] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:13:0) after 5m7s
[21:05:14.119] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:13:0)
[21:05:14.139] Build status: SCHEDULED
[21:05:14.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:14:0) after 7m13s
[21:12:27.150] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:14:0)
[21:12:27.177] Build status: SCHEDULED
[21:12:27.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:15:0) after 2m14s
[21:14:41.187] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:15:0)
[21:14:41.206] Build status: SCHEDULED
[21:14:41.206] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:16:0) after 6m51s
[21:21:32.220] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:16:0)
[21:21:32.240] Build status: SCHEDULED
[21:21:32.240] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:17:0) after 4m11s
[21:25:43.233] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:17:0)
[21:25:43.309] Build status: SCHEDULED
[21:25:43.309] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:18:0) after 3m21s
[21:29:04.319] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:18:0)
[21:29:04.341] Build status: SCHEDULED
[21:29:04.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:19:0) after 1m56s
[21:31:00.494] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:19:0)
[21:31:00.512] Build status: SCHEDULED
[21:31:00.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:20:0) after 1m42s
[21:32:42.627] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:20:0)
[21:32:42.673] Build status: SCHEDULED
[21:32:42.673] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:21:0) after 2m45s
[21:35:27.684] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:21:0)
[21:35:27.752] Build status: SCHEDULED
[21:35:27.752] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:22:0) after 9m7s
[21:44:34.912] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:22:0)
[21:44:34.931] Build status: SCHEDULED
[21:44:34.931] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:23:0) after 5m5s
[21:49:39.943] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:23:0)
[21:49:39.961] Build status: SCHEDULED
[21:49:39.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:24:0) after 9m24s
[21:59:04.076] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:24:0)
[21:59:04.094] Build status: SCHEDULED
[21:59:04.094] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:25:0) after 4m44s
[22:03:48.109] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:25:0)
[22:03:48.127] Build status: SCHEDULED
[22:03:48.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:26:0) after 3m11s
[22:06:59.239] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:26:0)
[22:06:59.259] Build status: SCHEDULED
[22:06:59.259] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:27:0) after 4m57s
[22:11:56.337] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:27:0)
[22:11:56.366] Build status: SCHEDULED
[22:11:56.366] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:28:0) after 1m11s
[22:13:07.463] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:28:0)
[22:13:07.481] Build status: SCHEDULED
[22:13:07.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:29:0) after 5m19s
[22:18:26.699] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:29:0)
[22:18:26.717] Build status: SCHEDULED
[22:18:26.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:30:0) after 3m2s
[22:21:28.731] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:30:0)
[22:21:28.760] Build status: SCHEDULED
[22:21:28.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:31:0) after 9m21s
[22:30:49.838] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:31:0)
[22:30:49.857] Build status: SCHEDULED
[22:30:49.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:32:0) after 2m46s
[22:33:35.922] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:32:0)
[22:33:35.939] Build status: SCHEDULED
[22:33:35.939] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:33:0) after 7m7s
[22:40:42.988] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:33:0)
[22:40:43.052] Build status: SCHEDULED
[22:40:43.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:34:0) after 6m22s
[22:47:05.777] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:34:0)
[22:47:05.794] Build status: SCHEDULED
[22:47:05.795] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:35:0) after 5m51s
[22:52:56.806] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:35:0)
[22:52:56.828] Build status: SCHEDULED
[22:52:56.828] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:36:0) after 6m41s
[22:59:37.814] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:36:0)
[22:59:37.833] Build status: SCHEDULED
[22:59:37.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:37:0) after 9m32s
[23:09:09.951] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:37:0)
[23:09:09.970] Build status: SCHEDULED
[23:09:09.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:38:0) after 1m53s
[23:11:03.013] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:38:0)
[23:11:03.034] Build status: SCHEDULED
[23:11:03.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:39:0) after 8m22s
[23:19:25.096] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:39:0)
[23:19:25.127] Build status: SCHEDULED
[23:19:25.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:40:0) after 1m16s
[23:20:41.145] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:40:0)
[23:20:41.184] Build status: SCHEDULED
[23:20:41.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:41:0) after 3m42s
[23:24:23.301] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:41:0)
[23:24:23.326] Build status: SCHEDULED
[23:24:23.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:42:0) after 7m21s
[23:31:44.357] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:42:0)
[23:31:44.401] Build status: SCHEDULED
[23:31:44.401] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:43:0) after 7m37s
[23:39:21.416] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:43:0)
[23:39:21.520] Build status: SCHEDULED
[23:39:21.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:44:0) after 5m22s
[23:44:43.580] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:44:0)
[23:44:43.668] Build status: SCHEDULED
[23:44:43.668] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:45:0) after 5m0s
[23:49:43.681] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:45:0)
[23:49:43.799] Build status: SCHEDULED
[23:49:43.799] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:46:0) after 1m2s
[23:50:45.836] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:46:0)
[23:50:45.855] Build status: SCHEDULED
[23:50:45.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:47:0) after 9m15s
[00:00:00.904] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:47:0)
[00:00:00.931] Build status: SCHEDULED
[00:00:00.931] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:48:0) after 1m7s
[00:01:07.939] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:48:0)
[00:01:07.970] Build status: SCHEDULED
[00:01:07.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:49:0) after 4m17s
[00:05:25.107] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:49:0)
[00:05:25.182] Build status: SCHEDULED
[00:05:25.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:50:0) after 2m30s
[00:07:55.431] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:50:0)
[00:07:55.452] Build status: SCHEDULED
[00:07:55.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:51:0) after 7m33s
[00:09:37.627] Received PubSub notification, asking Buildbucket for the build status
[00:09:37.649] Build status: STARTED
[00:15:28.647] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:51:0)
[00:15:29.122] Build status: STARTED
[00:15:29.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:53:0) after 5m52s
[00:21:21.256] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:53:0)
[00:21:21.277] Build status: STARTED
[00:21:21.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:54:0) after 3m36s
[00:24:57.402] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:54:0)
[00:24:57.424] Build status: STARTED
[00:24:57.424] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:55:0) after 1m46s
[00:26:43.599] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:55:0)
[00:26:43.769] Build status: STARTED
[00:26:43.769] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:56:0) after 1m18s
[00:28:01.783] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:56:0)
[00:28:01.813] Build status: STARTED
[00:28:01.814] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:57:0) after 4m47s
[00:32:48.822] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:57:0)
[00:32:48.842] Build status: STARTED
[00:32:48.842] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:58:0) after 5m20s
[00:38:08.875] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:58:0)
[00:38:08.893] Build status: STARTED
[00:38:08.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:59:0) after 5m15s
[00:43:24.033] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:59:0)
[00:43:24.070] Build status: STARTED
[00:43:24.070] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:60:0) after 5m27s
[00:48:51.083] Handling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:60:0)
[00:48:51.107] Build status: STARTED
[00:48:51.107] Scheduling timer "check-buildbucket-build-status" (r8/linux-android-14:8847590259502608704:61:0) after 5m19s
[00:49:06.941] Received PubSub notification, asking Buildbucket for the build status
[00:49:06.964] Build:
{
"id": "8682160197597183745",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-android-14"
},
"number": 1661,
"createdBy": "project:r8",
"createTime": "2026-05-10T20:10:30.834370750Z",
"startTime": "2026-05-11T00:09:34.480242298Z",
"endTime": "2026-05-11T00:49:06.722039129Z",
"updateTime": "2026-05-11T00:49:06.722039129Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8ae166610b37bb7e075da9d751459f0823e96958",
"ref": "refs/heads/main"
}
}
}
[00:49:06.964] Invocation finished in 4h38m37.329856834s with status SUCCEEDED