[12:30:22.633] New invocation is queued and will start shortly
[12:30:23.705] Starting the invocation (attempt 1)
[12:30:23.739] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cf31bf6e881dc469b69e40b82a4e3b8c39951ce7"
[12:30:23.739] Popped gitiles commit info from properties and tags
[12:30:23.739] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:30:23.740] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:30:23.741] Buildbucket request:
{
"requestId": "8857403679917146576",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cf31bf6e881dc469b69e40b82a4e3b8c39951ce7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857403679917146576"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-build-perf-developer"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:30:24.236] Scheduled build:
{
"id": "8691973618028873697",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 8782,
"createdBy": "project:chromium",
"createTime": "2026-01-22T12:30:23.813333935Z",
"updateTime": "2026-01-22T12:30:23.813333935Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cf31bf6e881dc469b69e40b82a4e3b8c39951ce7",
"ref": "refs/heads/main"
}
}
}
[12:30:24.236] Task URL: https://cr-buildbucket.appspot.com/build/8691973618028873697
[12:30:24.236] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:2:0) after 8m55s
[12:30:25.212] Received PubSub notification, asking Buildbucket for the build status
[12:30:25.232] Build status: SCHEDULED
[12:30:27.785] Received PubSub notification, asking Buildbucket for the build status
[12:30:27.811] Build status: STARTED
[12:39:19.256] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:2:0)
[12:39:19.281] Build status: STARTED
[12:39:19.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:5:0) after 1m12s
[12:40:31.297] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:5:0)
[12:40:31.315] Build status: STARTED
[12:40:31.315] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:6:0) after 1m45s
[12:42:16.334] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:6:0)
[12:42:16.363] Build status: STARTED
[12:42:16.363] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:7:0) after 9m2s
[12:51:18.444] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:7:0)
[12:51:18.476] Build status: STARTED
[12:51:18.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:8:0) after 2m6s
[12:53:24.564] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:8:0)
[12:53:24.581] Build status: STARTED
[12:53:24.581] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:9:0) after 2m34s
[12:55:58.647] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:9:0)
[12:55:58.662] Build status: STARTED
[12:55:58.662] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:10:0) after 7m41s
[13:03:39.745] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:10:0)
[13:03:39.764] Build status: STARTED
[13:03:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:11:0) after 8m7s
[13:11:46.797] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:11:0)
[13:11:46.840] Build status: STARTED
[13:11:46.840] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:12:0) after 8m31s
[13:20:17.910] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:12:0)
[13:20:17.962] Build status: STARTED
[13:20:17.962] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:13:0) after 9m54s
[13:30:11.978] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:13:0)
[13:30:12.009] Build status: STARTED
[13:30:12.009] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:14:0) after 3m0s
[13:33:12.031] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:14:0)
[13:33:12.049] Build status: STARTED
[13:33:12.049] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:15:0) after 2m42s
[13:35:54.028] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:15:0)
[13:35:54.050] Build status: STARTED
[13:35:54.050] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:16:0) after 8m10s
[13:44:04.078] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:16:0)
[13:44:04.098] Build status: STARTED
[13:44:04.098] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:17:0) after 5m32s
[13:49:36.103] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:17:0)
[13:49:36.142] Build status: STARTED
[13:49:36.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:18:0) after 1m2s
[13:50:38.167] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:18:0)
[13:50:38.190] Build status: STARTED
[13:50:38.191] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:19:0) after 2m22s
[13:53:00.220] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:19:0)
[13:53:00.239] Build status: STARTED
[13:53:00.239] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:20:0) after 3m4s
[13:56:04.256] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:20:0)
[13:56:04.271] Build status: STARTED
[13:56:04.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:21:0) after 9m19s
[14:05:23.251] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:21:0)
[14:05:23.269] Build status: STARTED
[14:05:23.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:22:0) after 2m3s
[14:07:26.308] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:22:0)
[14:07:26.345] Build status: STARTED
[14:07:26.345] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:23:0) after 7m16s
[14:14:42.407] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:23:0)
[14:14:42.675] Build status: STARTED
[14:14:42.675] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:24:0) after 2m28s
[14:17:10.692] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:24:0)
[14:17:10.737] Build status: STARTED
[14:17:10.737] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:25:0) after 3m38s
[14:20:48.805] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:25:0)
[14:20:48.839] Build status: STARTED
[14:20:48.839] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:26:0) after 7m19s
[14:28:07.929] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:26:0)
[14:28:07.942] Build status: STARTED
[14:28:07.942] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:27:0) after 3m28s
[14:31:36.028] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:27:0)
[14:31:36.045] Build status: STARTED
[14:31:36.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:28:0) after 9m38s
[14:41:14.193] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:28:0)
[14:41:14.262] Build status: STARTED
[14:41:14.262] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:29:0) after 2m54s
[14:44:08.276] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:29:0)
[14:44:08.296] Build status: STARTED
[14:44:08.296] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:30:0) after 6m35s
[14:50:43.387] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:30:0)
[14:50:43.404] Build status: STARTED
[14:50:43.404] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:31:0) after 5m1s
[14:55:44.407] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:31:0)
[14:55:44.545] Build status: STARTED
[14:55:44.546] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:32:0) after 5m10s
[15:00:54.564] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:32:0)
[15:00:54.783] Build status: STARTED
[15:00:54.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:33:0) after 8m41s
[15:09:35.805] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:33:0)
[15:09:35.823] Build status: STARTED
[15:09:35.823] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:34:0) after 2m53s
[15:12:28.831] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:34:0)
[15:12:29.002] Build status: STARTED
[15:12:29.002] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:35:0) after 7m15s
[15:19:44.075] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:35:0)
[15:19:44.097] Build status: STARTED
[15:19:44.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:36:0) after 5m41s
[15:25:25.128] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:36:0)
[15:25:25.146] Build status: STARTED
[15:25:25.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:37:0) after 7m30s
[15:32:55.168] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:37:0)
[15:32:55.182] Build status: STARTED
[15:32:55.182] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:38:0) after 8m42s
[15:41:37.256] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:38:0)
[15:41:37.271] Build status: STARTED
[15:41:37.272] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:39:0) after 5m27s
[15:47:04.299] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:39:0)
[15:47:04.333] Build status: STARTED
[15:47:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:40:0) after 9m25s
[15:56:29.406] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:40:0)
[15:56:29.423] Build status: STARTED
[15:56:29.423] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:41:0) after 7m3s
[16:03:32.461] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:41:0)
[16:03:32.480] Build status: STARTED
[16:03:32.480] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:42:0) after 6m19s
[16:09:51.665] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:42:0)
[16:09:51.740] Build status: STARTED
[16:09:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:43:0) after 3m19s
[16:13:10.750] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:43:0)
[16:13:10.764] Build status: STARTED
[16:13:10.764] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:44:0) after 7m43s
[16:20:53.859] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:44:0)
[16:20:53.891] Build status: STARTED
[16:20:53.891] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:45:0) after 2m51s
[16:23:44.927] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:45:0)
[16:23:44.943] Build status: STARTED
[16:23:44.943] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:46:0) after 4m33s
[16:28:17.992] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:46:0)
[16:28:18.059] Build status: STARTED
[16:28:18.059] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8857403679917146576:47:0) after 1m29s
[16:29:06.026] Received PubSub notification, asking Buildbucket for the build status
[16:29:06.045] Build:
{
"id": "8691973618028873697",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 8782,
"createdBy": "project:chromium",
"createTime": "2026-01-22T12:30:23.813333935Z",
"startTime": "2026-01-22T12:30:27.601774885Z",
"endTime": "2026-01-22T16:29:05.087197839Z",
"updateTime": "2026-01-22T16:29:05.087197839Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cf31bf6e881dc469b69e40b82a4e3b8c39951ce7",
"ref": "refs/heads/main"
}
}
}
[16:29:06.045] Invocation finished in 3h58m43.416564562s with status SUCCEEDED