[12:01:14.294] New invocation is queued and will start shortly
[12:01:15.938] Starting the invocation (attempt 1)
[12:01:15.968] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/8a506201b25a1b3d64180d3faa4ab215325d1f9d"
[12:01:15.968] Popped gitiles commit info from properties and tags
[12:01:15.968] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:01:15.968] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:01:15.968] Buildbucket request:
{
"requestId": "8836115226082291152",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "perf"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836115226082291152",
"job": "r8/perf",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "8a506201b25a1b3d64180d3faa4ab215325d1f9d"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@8a506201b25a1b3d64180d3faa4ab215325d1f9d",
"title": "8a506201b25a1b3d64180d3faa4ab215325d1f9d",
"url": "https://r8.googlesource.com/r8/+/8a506201b25a1b3d64180d3faa4ab215325d1f9d"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8a506201b25a1b3d64180d3faa4ab215325d1f9d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836115226082291152"
},
{
"key": "scheduler_job_id",
"value": "r8/perf"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:01:16.511] Scheduled build:
{
"id": "8670685163597235425",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "perf"
},
"number": 3438,
"createdBy": "project:r8",
"createTime": "2026-09-14T12:01:16.040830123Z",
"updateTime": "2026-09-14T12:01:16.040830123Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8a506201b25a1b3d64180d3faa4ab215325d1f9d",
"ref": "refs/heads/main"
}
}
}
[12:01:16.511] Task URL: https://cr-buildbucket.appspot.com/build/8670685163597235425
[12:01:16.511] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:2:0) after 2m22s
[12:01:17.467] Received PubSub notification, asking Buildbucket for the build status
[12:01:17.496] Build status: SCHEDULED
[12:03:38.572] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:2:0)
[12:03:38.602] Build status: SCHEDULED
[12:03:38.602] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:4:0) after 4m46s
[12:08:24.667] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:4:0)
[12:08:24.696] Build status: SCHEDULED
[12:08:24.696] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:5:0) after 7m15s
[12:15:39.782] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:5:0)
[12:15:39.807] Build status: SCHEDULED
[12:15:39.807] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:6:0) after 1m47s
[12:17:26.824] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:6:0)
[12:17:26.848] Build status: SCHEDULED
[12:17:26.848] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:7:0) after 7m26s
[12:24:52.967] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:7:0)
[12:24:53.055] Build status: SCHEDULED
[12:24:53.055] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:8:0) after 1m30s
[12:26:23.175] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:8:0)
[12:26:23.194] Build status: SCHEDULED
[12:26:23.194] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:9:0) after 6m14s
[12:32:37.276] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:9:0)
[12:32:37.305] Build status: SCHEDULED
[12:32:37.305] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:10:0) after 1m52s
[12:34:29.413] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:10:0)
[12:34:29.434] Build status: SCHEDULED
[12:34:29.434] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:11:0) after 1m54s
[12:36:23.447] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:11:0)
[12:36:23.468] Build status: SCHEDULED
[12:36:23.468] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:12:0) after 7m57s
[12:44:20.515] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:12:0)
[12:44:20.550] Build status: SCHEDULED
[12:44:20.551] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:13:0) after 1m25s
[12:45:45.581] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:13:0)
[12:45:45.602] Build status: SCHEDULED
[12:45:45.602] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:14:0) after 6m48s
[12:52:33.640] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:14:0)
[12:52:33.660] Build status: SCHEDULED
[12:52:33.660] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:15:0) after 3m16s
[12:55:49.677] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:15:0)
[12:55:49.703] Build status: SCHEDULED
[12:55:49.703] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:16:0) after 8m38s
[13:04:27.907] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:16:0)
[13:04:27.928] Build status: SCHEDULED
[13:04:27.928] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:17:0) after 5m0s
[13:09:27.998] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:17:0)
[13:09:28.016] Build status: SCHEDULED
[13:09:28.016] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:18:0) after 1m12s
[13:10:40.130] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:18:0)
[13:10:40.153] Build status: SCHEDULED
[13:10:40.153] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:19:0) after 5m36s
[13:16:16.182] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:19:0)
[13:16:16.201] Build status: SCHEDULED
[13:16:16.201] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:20:0) after 2m58s
[13:19:14.250] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:20:0)
[13:19:14.270] Build status: SCHEDULED
[13:19:14.270] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:21:0) after 3m37s
[13:22:51.536] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:21:0)
[13:22:51.558] Build status: SCHEDULED
[13:22:51.558] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:22:0) after 7m9s
[13:30:00.650] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:22:0)
[13:30:00.755] Build status: SCHEDULED
[13:30:00.755] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:23:0) after 1m16s
[13:31:16.772] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:23:0)
[13:31:16.811] Build status: SCHEDULED
[13:31:16.811] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:24:0) after 3m58s
[13:35:14.866] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:24:0)
[13:35:14.890] Build status: SCHEDULED
[13:35:14.890] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:25:0) after 5m45s
[13:40:59.932] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:25:0)
[13:40:59.953] Build status: SCHEDULED
[13:40:59.953] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:26:0) after 1m45s
[13:42:44.968] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:26:0)
[13:42:44.991] Build status: SCHEDULED
[13:42:44.991] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:27:0) after 4m11s
[13:46:55.993] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:27:0)
[13:46:56.015] Build status: SCHEDULED
[13:46:56.015] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:28:0) after 3m25s
[13:50:21.080] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:28:0)
[13:50:21.140] Build status: SCHEDULED
[13:50:21.140] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:29:0) after 1m6s
[13:51:27.204] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:29:0)
[13:51:27.222] Build status: SCHEDULED
[13:51:27.222] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:30:0) after 2m38s
[13:54:05.239] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:30:0)
[13:54:05.260] Build status: SCHEDULED
[13:54:05.260] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:31:0) after 3m0s
[13:57:05.275] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:31:0)
[13:57:05.292] Build status: SCHEDULED
[13:57:05.292] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:32:0) after 8m18s
[14:05:23.309] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:32:0)
[14:05:23.356] Build status: SCHEDULED
[14:05:23.356] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:33:0) after 5m3s
[14:10:26.378] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:33:0)
[14:10:26.396] Build status: SCHEDULED
[14:10:26.396] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:34:0) after 6m17s
[14:16:43.392] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:34:0)
[14:16:43.424] Build status: SCHEDULED
[14:16:43.424] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:35:0) after 1m21s
[14:18:04.473] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:35:0)
[14:18:04.502] Build status: SCHEDULED
[14:18:04.502] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:36:0) after 6m21s
[14:24:25.599] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:36:0)
[14:24:25.621] Build status: SCHEDULED
[14:24:25.621] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:37:0) after 9m33s
[14:33:58.633] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:37:0)
[14:33:58.665] Build status: SCHEDULED
[14:33:58.665] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:38:0) after 7m6s
[14:41:04.680] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:38:0)
[14:41:04.749] Build status: SCHEDULED
[14:41:04.749] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:39:0) after 6m56s
[14:48:00.907] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:39:0)
[14:48:00.928] Build status: SCHEDULED
[14:48:00.928] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:40:0) after 4m42s
[14:52:43.077] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:40:0)
[14:52:43.099] Build status: SCHEDULED
[14:52:43.099] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:41:0) after 6m28s
[14:59:11.210] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:41:0)
[14:59:11.237] Build status: SCHEDULED
[14:59:11.237] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:42:0) after 6m3s
[15:05:14.306] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:42:0)
[15:05:14.328] Build status: SCHEDULED
[15:05:14.328] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:43:0) after 1m44s
[15:06:58.396] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:43:0)
[15:06:58.423] Build status: SCHEDULED
[15:06:58.423] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:44:0) after 8m50s
[15:15:48.410] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:44:0)
[15:15:48.434] Build status: SCHEDULED
[15:15:48.434] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:45:0) after 8m57s
[15:24:45.543] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:45:0)
[15:24:45.586] Build status: SCHEDULED
[15:24:45.586] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:46:0) after 4m21s
[15:29:06.584] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:46:0)
[15:29:06.607] Build status: SCHEDULED
[15:29:06.607] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:47:0) after 2m20s
[15:31:26.676] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:47:0)
[15:31:26.699] Build status: SCHEDULED
[15:31:26.700] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:48:0) after 7m6s
[15:38:32.706] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:48:0)
[15:38:32.732] Build status: SCHEDULED
[15:38:32.732] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:49:0) after 8m49s
[15:47:21.789] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:49:0)
[15:47:21.811] Build status: SCHEDULED
[15:47:21.811] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:50:0) after 1m32s
[15:48:53.829] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:50:0)
[15:48:53.853] Build status: SCHEDULED
[15:48:53.853] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:51:0) after 9m7s
[15:58:00.874] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:51:0)
[15:58:00.994] Build status: SCHEDULED
[15:58:00.994] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:52:0) after 1m16s
[15:59:17.128] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:52:0)
[15:59:17.155] Build status: SCHEDULED
[15:59:17.155] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:53:0) after 6m33s
[16:05:50.175] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:53:0)
[16:05:50.209] Build status: SCHEDULED
[16:05:50.209] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:54:0) after 1m25s
[16:07:15.254] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:54:0)
[16:07:15.274] Build status: SCHEDULED
[16:07:15.274] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:55:0) after 5m9s
[16:12:24.305] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:55:0)
[16:12:24.326] Build status: SCHEDULED
[16:12:24.326] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:56:0) after 5m53s
[16:18:17.343] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:56:0)
[16:18:17.365] Build status: SCHEDULED
[16:18:17.365] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:57:0) after 8m0s
[16:26:17.397] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:57:0)
[16:26:17.425] Build status: SCHEDULED
[16:26:17.425] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:58:0) after 1m17s
[16:27:34.444] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:58:0)
[16:27:34.486] Build status: SCHEDULED
[16:27:34.486] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:59:0) after 7m45s
[16:35:19.555] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:59:0)
[16:35:19.576] Build status: SCHEDULED
[16:35:19.576] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:60:0) after 8m15s
[16:43:34.605] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:60:0)
[16:43:34.635] Build status: SCHEDULED
[16:43:34.635] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:61:0) after 9m19s
[16:52:53.724] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:61:0)
[16:52:53.742] Build status: SCHEDULED
[16:52:53.742] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:62:0) after 5m22s
[16:58:15.784] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:62:0)
[16:58:15.812] Build status: SCHEDULED
[16:58:15.812] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:63:0) after 2m0s
[17:00:15.840] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:63:0)
[17:00:15.857] Build status: SCHEDULED
[17:00:15.857] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:64:0) after 5m20s
[17:05:35.973] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:64:0)
[17:05:35.992] Build status: SCHEDULED
[17:05:35.992] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:65:0) after 9m44s
[17:15:20.031] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:65:0)
[17:15:20.052] Build status: SCHEDULED
[17:15:20.052] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:66:0) after 2m43s
[17:18:03.135] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:66:0)
[17:18:03.156] Build status: SCHEDULED
[17:18:03.156] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:67:0) after 2m55s
[17:20:58.235] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:67:0)
[17:20:58.409] Build status: SCHEDULED
[17:20:58.409] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:68:0) after 1m42s
[17:22:40.583] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:68:0)
[17:22:40.608] Build status: SCHEDULED
[17:22:40.608] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:69:0) after 3m44s
[17:26:24.628] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:69:0)
[17:26:24.683] Build status: SCHEDULED
[17:26:24.683] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:70:0) after 2m30s
[17:28:54.696] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:70:0)
[17:28:54.719] Build status: SCHEDULED
[17:28:54.719] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:71:0) after 4m56s
[17:33:50.743] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:71:0)
[17:33:50.771] Build status: SCHEDULED
[17:33:50.771] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:72:0) after 1m59s
[17:35:49.790] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:72:0)
[17:35:49.810] Build status: SCHEDULED
[17:35:49.810] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:73:0) after 4m42s
[17:40:31.826] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:73:0)
[17:40:31.844] Build status: SCHEDULED
[17:40:31.844] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:74:0) after 3m56s
[17:44:27.998] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:74:0)
[17:44:28.035] Build status: SCHEDULED
[17:44:28.035] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:75:0) after 8m25s
[17:52:53.024] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:75:0)
[17:52:53.042] Build status: SCHEDULED
[17:52:53.042] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:76:0) after 2m9s
[17:55:02.146] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:76:0)
[17:55:02.166] Build status: SCHEDULED
[17:55:02.166] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:77:0) after 6m24s
[18:01:26.167] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:77:0)
[18:01:26.201] Build status: SCHEDULED
[18:01:26.201] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:78:0) after 5m21s
[18:06:47.391] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:78:0)
[18:06:47.412] Build status: SCHEDULED
[18:06:47.412] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:79:0) after 9m15s
[18:16:02.438] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:79:0)
[18:16:02.666] Build status: SCHEDULED
[18:16:02.666] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:80:0) after 4m58s
[18:21:00.704] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:80:0)
[18:21:00.727] Build status: SCHEDULED
[18:21:00.727] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:81:0) after 2m56s
[18:23:56.816] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:81:0)
[18:23:56.832] Build status: SCHEDULED
[18:23:56.832] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:82:0) after 8m51s
[18:32:47.930] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:82:0)
[18:32:47.953] Build status: SCHEDULED
[18:32:47.953] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:83:0) after 2m21s
[18:35:09.008] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:83:0)
[18:35:09.089] Build status: SCHEDULED
[18:35:09.089] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:84:0) after 2m8s
[18:37:17.117] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:84:0)
[18:37:17.134] Build status: SCHEDULED
[18:37:17.134] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:85:0) after 1m32s
[18:38:49.210] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:85:0)
[18:38:49.231] Build status: SCHEDULED
[18:38:49.231] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:86:0) after 2m25s
[18:41:14.367] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:86:0)
[18:41:14.391] Build status: SCHEDULED
[18:41:14.391] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:87:0) after 7m9s
[18:48:23.391] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:87:0)
[18:48:23.441] Build status: SCHEDULED
[18:48:23.441] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:88:0) after 6m34s
[18:54:57.503] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:88:0)
[18:54:57.526] Build status: SCHEDULED
[18:54:57.526] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:89:0) after 8m26s
[19:03:23.589] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:89:0)
[19:03:23.621] Build status: SCHEDULED
[19:03:23.621] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:90:0) after 2m25s
[19:05:48.701] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:90:0)
[19:05:48.722] Build status: SCHEDULED
[19:05:48.722] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:91:0) after 5m39s
[19:11:27.810] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:91:0)
[19:11:27.836] Build status: SCHEDULED
[19:11:27.836] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:92:0) after 2m5s
[19:13:32.952] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:92:0)
[19:13:32.973] Build status: SCHEDULED
[19:13:32.973] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:93:0) after 4m8s
[19:17:40.993] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:93:0)
[19:17:41.046] Build status: SCHEDULED
[19:17:41.046] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:94:0) after 2m21s
[19:20:02.049] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:94:0)
[19:20:02.079] Build status: SCHEDULED
[19:20:02.079] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:95:0) after 1m40s
[19:21:42.146] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:95:0)
[19:21:42.358] Build status: SCHEDULED
[19:21:42.358] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:96:0) after 2m51s
[19:24:33.447] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:96:0)
[19:24:33.587] Build status: SCHEDULED
[19:24:33.587] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:97:0) after 6m41s
[19:31:14.691] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:97:0)
[19:31:14.713] Build status: SCHEDULED
[19:31:14.713] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:98:0) after 8m26s
[19:39:40.731] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:98:0)
[19:39:40.754] Build status: SCHEDULED
[19:39:40.754] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:99:0) after 9m20s
[19:49:00.869] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:99:0)
[19:49:00.888] Build status: SCHEDULED
[19:49:00.888] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:100:0) after 3m28s
[19:52:28.906] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:100:0)
[19:52:28.926] Build status: SCHEDULED
[19:52:28.926] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:101:0) after 3m3s
[19:55:31.958] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:101:0)
[19:55:31.977] Build status: SCHEDULED
[19:55:31.977] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:102:0) after 3m33s
[19:59:04.994] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:102:0)
[19:59:05.014] Build status: SCHEDULED
[19:59:05.014] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:103:0) after 5m45s
[20:04:50.273] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:103:0)
[20:04:50.295] Build status: SCHEDULED
[20:04:50.295] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:104:0) after 1m28s
[20:06:18.310] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:104:0)
[20:06:18.432] Build status: SCHEDULED
[20:06:18.432] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:105:0) after 6m20s
[20:12:38.451] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:105:0)
[20:12:38.474] Build status: SCHEDULED
[20:12:38.474] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:106:0) after 7m25s
[20:20:03.571] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:106:0)
[20:20:03.590] Build status: SCHEDULED
[20:20:03.590] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:107:0) after 2m30s
[20:22:33.706] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:107:0)
[20:22:33.725] Build status: SCHEDULED
[20:22:33.725] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:108:0) after 2m24s
[20:24:57.791] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:108:0)
[20:24:57.813] Build status: SCHEDULED
[20:24:57.813] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:109:0) after 3m8s
[20:28:06.001] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:109:0)
[20:28:06.024] Build status: SCHEDULED
[20:28:06.024] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:110:0) after 4m9s
[20:32:15.069] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:110:0)
[20:32:15.122] Build status: SCHEDULED
[20:32:15.122] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:111:0) after 2m51s
[20:35:06.237] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:111:0)
[20:35:06.259] Build status: SCHEDULED
[20:35:06.260] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:112:0) after 2m10s
[20:37:16.314] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:112:0)
[20:37:16.340] Build status: SCHEDULED
[20:37:16.340] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:113:0) after 4m18s
[20:41:34.356] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:113:0)
[20:41:34.451] Build status: SCHEDULED
[20:41:34.451] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:114:0) after 8m35s
[20:50:09.422] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:114:0)
[20:50:09.446] Build status: SCHEDULED
[20:50:09.446] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:115:0) after 1m0s
[20:51:09.464] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:115:0)
[20:51:09.488] Build status: SCHEDULED
[20:51:09.488] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:116:0) after 3m54s
[20:55:03.630] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:116:0)
[20:55:03.662] Build status: SCHEDULED
[20:55:03.662] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:117:0) after 1m43s
[20:56:46.678] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:117:0)
[20:56:46.695] Build status: SCHEDULED
[20:56:46.695] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:118:0) after 5m17s
[21:02:03.712] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:118:0)
[21:02:03.787] Build status: SCHEDULED
[21:02:03.788] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:119:0) after 9m49s
[21:11:52.798] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:119:0)
[21:11:52.814] Build status: SCHEDULED
[21:11:52.814] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:120:0) after 9m45s
[21:21:37.863] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:120:0)
[21:21:37.882] Build status: SCHEDULED
[21:21:37.883] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:121:0) after 5m9s
[21:26:46.900] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:121:0)
[21:26:46.917] Build status: SCHEDULED
[21:26:46.917] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:122:0) after 2m19s
[21:29:05.969] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:122:0)
[21:29:05.993] Build status: SCHEDULED
[21:29:05.994] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:123:0) after 8m7s
[21:37:13.175] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:123:0)
[21:37:13.191] Build status: SCHEDULED
[21:37:13.191] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:124:0) after 1m56s
[21:39:09.212] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:124:0)
[21:39:09.235] Build status: SCHEDULED
[21:39:09.235] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:125:0) after 8m30s
[21:47:39.414] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:125:0)
[21:47:39.438] Build status: SCHEDULED
[21:47:39.439] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:126:0) after 4m27s
[21:52:06.481] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:126:0)
[21:52:06.574] Build status: SCHEDULED
[21:52:06.574] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:127:0) after 3m16s
[21:55:22.714] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:127:0)
[21:55:22.740] Build status: SCHEDULED
[21:55:22.740] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:128:0) after 9m26s
[22:04:48.830] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:128:0)
[22:04:48.851] Build status: SCHEDULED
[22:04:48.851] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:129:0) after 3m36s
[22:08:24.967] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:129:0)
[22:08:25.021] Build status: SCHEDULED
[22:08:25.021] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:130:0) after 7m3s
[22:15:28.003] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:130:0)
[22:15:28.026] Build status: SCHEDULED
[22:15:28.026] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:131:0) after 9m51s
[22:25:19.146] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:131:0)
[22:25:19.262] Build status: SCHEDULED
[22:25:19.262] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:132:0) after 1m30s
[22:26:49.279] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:132:0)
[22:26:49.440] Build status: SCHEDULED
[22:26:49.441] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:133:0) after 6m23s
[22:33:12.481] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:133:0)
[22:33:12.534] Build status: SCHEDULED
[22:33:12.534] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:134:0) after 6m32s
[22:39:44.668] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:134:0)
[22:39:44.691] Build status: SCHEDULED
[22:39:44.691] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:135:0) after 9m36s
[22:49:20.829] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:135:0)
[22:49:20.854] Build status: SCHEDULED
[22:49:20.854] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:136:0) after 2m22s
[22:51:42.875] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:136:0)
[22:51:42.900] Build status: SCHEDULED
[22:51:42.900] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:137:0) after 8m17s
[22:59:59.916] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:137:0)
[22:59:59.941] Build status: SCHEDULED
[22:59:59.941] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:138:0) after 5m54s
[23:05:54.259] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:138:0)
[23:05:54.299] Build status: SCHEDULED
[23:05:54.299] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:139:0) after 9m18s
[23:15:12.360] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:139:0)
[23:15:12.383] Build status: SCHEDULED
[23:15:12.383] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:140:0) after 7m32s
[23:22:44.457] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:140:0)
[23:22:44.476] Build status: SCHEDULED
[23:22:44.476] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:141:0) after 4m47s
[23:27:31.495] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:141:0)
[23:27:31.536] Build status: SCHEDULED
[23:27:31.536] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:142:0) after 8m28s
[23:35:59.702] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:142:0)
[23:35:59.895] Build status: SCHEDULED
[23:35:59.895] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:143:0) after 4m19s
[23:40:18.917] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:143:0)
[23:40:18.936] Build status: SCHEDULED
[23:40:18.936] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:144:0) after 5m35s
[23:45:54.208] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:144:0)
[23:45:54.224] Build status: SCHEDULED
[23:45:54.224] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:145:0) after 7m26s
[23:53:20.273] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:145:0)
[23:53:20.294] Build status: SCHEDULED
[23:53:20.294] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:146:0) after 6m34s
[23:59:54.288] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:146:0)
[23:59:54.338] Build status: SCHEDULED
[23:59:54.338] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:147:0) after 5m41s
[00:05:35.443] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:147:0)
[00:05:35.488] Build status: SCHEDULED
[00:05:35.488] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:148:0) after 6m32s
[00:12:07.758] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:148:0)
[00:12:07.776] Build status: SCHEDULED
[00:12:07.776] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:149:0) after 3m3s
[00:15:10.912] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:149:0)
[00:15:10.934] Build status: SCHEDULED
[00:15:10.934] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:150:0) after 1m48s
[00:16:59.151] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:150:0)
[00:16:59.198] Build status: SCHEDULED
[00:16:59.198] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:151:0) after 8m41s
[00:25:40.388] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:151:0)
[00:25:40.417] Build status: SCHEDULED
[00:25:40.417] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:152:0) after 1m57s
[00:27:37.597] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:152:0)
[00:27:37.639] Build status: SCHEDULED
[00:27:37.639] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:153:0) after 2m10s
[00:29:47.721] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:153:0)
[00:29:47.766] Build status: SCHEDULED
[00:29:47.766] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:154:0) after 3m35s
[00:33:22.852] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:154:0)
[00:33:23.008] Build status: SCHEDULED
[00:33:23.008] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:155:0) after 4m1s
[00:37:24.281] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:155:0)
[00:37:24.300] Build status: SCHEDULED
[00:37:24.300] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:156:0) after 5m19s
[00:42:43.391] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:156:0)
[00:42:43.412] Build status: SCHEDULED
[00:42:43.412] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:157:0) after 1m3s
[00:43:46.590] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:157:0)
[00:43:46.637] Build status: SCHEDULED
[00:43:46.637] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:158:0) after 2m27s
[00:46:14.055] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:158:0)
[00:46:14.076] Build status: SCHEDULED
[00:46:14.076] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:159:0) after 6m16s
[00:52:30.168] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:159:0)
[00:52:30.190] Build status: SCHEDULED
[00:52:30.190] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:160:0) after 8m6s
[01:00:36.238] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:160:0)
[01:00:36.267] Build status: SCHEDULED
[01:00:36.267] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:161:0) after 8m12s
[01:08:48.334] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:161:0)
[01:08:48.355] Build status: SCHEDULED
[01:08:48.355] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:162:0) after 5m25s
[01:14:13.560] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:162:0)
[01:14:13.590] Build status: SCHEDULED
[01:14:13.590] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:163:0) after 6m28s
[01:20:41.657] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:163:0)
[01:20:41.729] Build status: SCHEDULED
[01:20:41.729] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:164:0) after 1m54s
[01:22:35.937] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:164:0)
[01:22:35.966] Build status: SCHEDULED
[01:22:35.966] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:165:0) after 1m10s
[01:23:46.102] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:165:0)
[01:23:46.130] Build status: SCHEDULED
[01:23:46.130] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:166:0) after 9m48s
[01:30:47.374] Received PubSub notification, asking Buildbucket for the build status
[01:30:47.404] Build status: STARTED
[01:33:34.176] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:166:0)
[01:33:34.209] Build status: STARTED
[01:33:34.209] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:168:0) after 2m43s
[01:36:17.229] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:168:0)
[01:36:17.250] Build status: STARTED
[01:36:17.250] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:169:0) after 5m1s
[01:41:18.269] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:169:0)
[01:41:18.381] Build status: STARTED
[01:41:18.381] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:170:0) after 2m15s
[01:43:33.437] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:170:0)
[01:43:33.457] Build status: STARTED
[01:43:33.457] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:171:0) after 4m14s
[01:47:47.558] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:171:0)
[01:47:47.579] Build status: STARTED
[01:47:47.579] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:172:0) after 2m14s
[01:50:01.604] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:172:0)
[01:50:01.636] Build status: STARTED
[01:50:01.636] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:173:0) after 1m44s
[01:51:45.657] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:173:0)
[01:51:45.676] Build status: STARTED
[01:51:45.677] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:174:0) after 6m48s
[01:58:33.860] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:174:0)
[01:58:33.886] Build status: STARTED
[01:58:33.886] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:175:0) after 3m19s
[02:01:53.008] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:175:0)
[02:01:53.028] Build status: STARTED
[02:01:53.028] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:176:0) after 2m13s
[02:04:06.101] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:176:0)
[02:04:06.177] Build status: STARTED
[02:04:06.177] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:177:0) after 5m41s
[02:09:47.259] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:177:0)
[02:09:47.295] Build status: STARTED
[02:09:47.295] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:178:0) after 5m7s
[02:14:54.344] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:178:0)
[02:14:54.365] Build status: STARTED
[02:14:54.365] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:179:0) after 7m26s
[02:22:20.414] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:179:0)
[02:22:20.443] Build status: STARTED
[02:22:20.443] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:180:0) after 8m55s
[02:31:15.501] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:180:0)
[02:31:15.523] Build status: STARTED
[02:31:15.523] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:181:0) after 3m1s
[02:34:16.594] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:181:0)
[02:34:16.685] Build status: STARTED
[02:34:16.685] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:182:0) after 4m21s
[02:38:37.754] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:182:0)
[02:38:37.773] Build status: STARTED
[02:38:37.774] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:183:0) after 5m46s
[02:44:23.793] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:183:0)
[02:44:23.822] Build status: STARTED
[02:44:23.822] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:184:0) after 2m3s
[02:46:26.927] Handling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:184:0)
[02:46:26.943] Build status: STARTED
[02:46:26.943] Scheduling timer "check-buildbucket-build-status" (r8/perf:8836115226082291152:185:0) after 7m16s
[02:50:54.031] Received PubSub notification, asking Buildbucket for the build status
[02:50:54.066] Build:
{
"id": "8670685163597235425",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "perf"
},
"number": 3438,
"createdBy": "project:r8",
"createTime": "2026-09-14T12:01:16.040830123Z",
"startTime": "2026-09-15T01:30:46.278403273Z",
"endTime": "2026-09-15T02:50:53.083719303Z",
"updateTime": "2026-09-15T02:50:53.083719303Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8a506201b25a1b3d64180d3faa4ab215325d1f9d",
"ref": "refs/heads/main"
}
}
}
[02:50:54.066] Invocation finished in 14h49m39.779411957s with status SUCCEEDED