[14:28:58.505] New invocation is queued and will start shortly
[14:28:59.678] Starting the invocation (attempt 1)
[14:28:59.701] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/2602e187e5adc31ec1363443a61b7a8c9939cfa3"
[14:28:59.701] Popped gitiles commit info from properties and tags
[14:28:59.701] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:28:59.701] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:28:59.701] Buildbucket request:
{
"requestId": "8834565782851313952",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "perf"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8834565782851313952",
"job": "r8/perf",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "2602e187e5adc31ec1363443a61b7a8c9939cfa3"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@2602e187e5adc31ec1363443a61b7a8c9939cfa3",
"title": "2602e187e5adc31ec1363443a61b7a8c9939cfa3",
"url": "https://r8.googlesource.com/r8/+/2602e187e5adc31ec1363443a61b7a8c9939cfa3"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "2602e187e5adc31ec1363443a61b7a8c9939cfa3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8834565782851313952"
},
{
"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"
}
}
[14:29:01.257] Scheduled build:
{
"id": "8669135720571324577",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "perf"
},
"number": 3673,
"createdBy": "project:r8",
"createTime": "2026-10-01T14:29:00.059958575Z",
"updateTime": "2026-10-01T14:29:00.059958575Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "2602e187e5adc31ec1363443a61b7a8c9939cfa3",
"ref": "refs/heads/main"
}
}
}
[14:29:01.257] Task URL: https://cr-buildbucket.appspot.com/build/8669135720571324577
[14:29:01.257] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:2:0) after 9m6s
[14:29:01.943] Received PubSub notification, asking Buildbucket for the build status
[14:29:02.031] Build status: SCHEDULED
[14:38:07.347] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:2:0)
[14:38:07.394] Build status: SCHEDULED
[14:38:07.394] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:4:0) after 5m52s
[14:43:59.465] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:4:0)
[14:43:59.504] Build status: SCHEDULED
[14:43:59.504] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:5:0) after 7m32s
[14:51:31.496] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:5:0)
[14:51:31.526] Build status: SCHEDULED
[14:51:31.526] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:6:0) after 8m58s
[15:00:29.622] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:6:0)
[15:00:29.669] Build status: SCHEDULED
[15:00:29.669] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:7:0) after 3m56s
[15:04:25.782] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:7:0)
[15:04:25.807] Build status: SCHEDULED
[15:04:25.807] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:8:0) after 6m47s
[15:11:12.874] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:8:0)
[15:11:12.903] Build status: SCHEDULED
[15:11:12.903] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:9:0) after 9m9s
[15:20:21.924] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:9:0)
[15:20:21.970] Build status: SCHEDULED
[15:20:21.971] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:10:0) after 7m5s
[15:27:27.038] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:10:0)
[15:27:27.062] Build status: SCHEDULED
[15:27:27.062] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:11:0) after 8m49s
[15:36:16.090] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:11:0)
[15:36:16.116] Build status: SCHEDULED
[15:36:16.116] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:12:0) after 9m42s
[15:45:58.137] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:12:0)
[15:45:58.345] Build status: SCHEDULED
[15:45:58.345] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:13:0) after 6m14s
[15:52:12.492] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:13:0)
[15:52:12.596] Build status: SCHEDULED
[15:52:12.597] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:14:0) after 9m47s
[16:01:59.949] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:14:0)
[16:01:59.970] Build status: SCHEDULED
[16:01:59.970] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:15:0) after 6m27s
[16:08:27.066] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:15:0)
[16:08:27.099] Build status: SCHEDULED
[16:08:27.099] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:16:0) after 3m48s
[16:12:15.143] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:16:0)
[16:12:15.208] Build status: SCHEDULED
[16:12:15.208] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:17:0) after 6m27s
[16:18:42.235] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:17:0)
[16:18:42.259] Build status: SCHEDULED
[16:18:42.259] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:18:0) after 4m23s
[16:23:05.311] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:18:0)
[16:23:05.333] Build status: SCHEDULED
[16:23:05.333] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:19:0) after 9m30s
[16:32:35.381] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:19:0)
[16:32:35.418] Build status: SCHEDULED
[16:32:35.418] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:20:0) after 1m52s
[16:34:27.392] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:20:0)
[16:34:27.453] Build status: SCHEDULED
[16:34:27.453] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:21:0) after 6m5s
[16:40:32.541] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:21:0)
[16:40:32.641] Build status: SCHEDULED
[16:40:32.641] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:22:0) after 6m30s
[16:47:02.646] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:22:0)
[16:47:02.667] Build status: SCHEDULED
[16:47:02.667] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:23:0) after 9m47s
[16:56:49.720] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:23:0)
[16:56:49.743] Build status: SCHEDULED
[16:56:49.743] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:24:0) after 3m39s
[17:00:28.762] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:24:0)
[17:00:28.884] Build status: SCHEDULED
[17:00:28.884] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:25:0) after 6m23s
[17:06:51.903] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:25:0)
[17:06:51.925] Build status: SCHEDULED
[17:06:51.925] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:26:0) after 9m47s
[17:16:38.976] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:26:0)
[17:16:39.228] Build status: SCHEDULED
[17:16:39.228] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:27:0) after 9m47s
[17:26:26.256] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:27:0)
[17:26:26.279] Build status: SCHEDULED
[17:26:26.279] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:28:0) after 5m59s
[17:32:25.296] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:28:0)
[17:32:25.316] Build status: SCHEDULED
[17:32:25.316] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:29:0) after 9m35s
[17:42:00.688] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:29:0)
[17:42:00.713] Build status: SCHEDULED
[17:42:00.713] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:30:0) after 2m26s
[17:44:26.728] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:30:0)
[17:44:26.781] Build status: SCHEDULED
[17:44:26.781] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:31:0) after 9m54s
[17:54:20.876] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:31:0)
[17:54:21.006] Build status: SCHEDULED
[17:54:21.006] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:32:0) after 8m43s
[18:03:04.020] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:32:0)
[18:03:04.106] Build status: SCHEDULED
[18:03:04.106] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:33:0) after 1m4s
[18:04:08.272] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:33:0)
[18:04:08.394] Build status: SCHEDULED
[18:04:08.394] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:34:0) after 2m26s
[18:06:34.497] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:34:0)
[18:06:34.521] Build status: SCHEDULED
[18:06:34.521] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:35:0) after 7m29s
[18:14:03.588] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:35:0)
[18:14:03.621] Build status: SCHEDULED
[18:14:03.622] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:36:0) after 3m31s
[18:17:34.750] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:36:0)
[18:17:34.771] Build status: SCHEDULED
[18:17:34.771] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:37:0) after 9m37s
[18:27:11.787] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:37:0)
[18:27:11.813] Build status: SCHEDULED
[18:27:11.813] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:38:0) after 2m8s
[18:29:19.859] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:38:0)
[18:29:19.968] Build status: SCHEDULED
[18:29:19.968] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:39:0) after 5m41s
[18:35:01.041] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:39:0)
[18:35:01.099] Build status: SCHEDULED
[18:35:01.099] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:40:0) after 9m21s
[18:44:22.114] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:40:0)
[18:44:22.140] Build status: SCHEDULED
[18:44:22.140] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:41:0) after 4m20s
[18:48:42.194] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:41:0)
[18:48:42.229] Build status: SCHEDULED
[18:48:42.229] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:42:0) after 8m32s
[18:57:14.243] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:42:0)
[18:57:14.365] Build status: SCHEDULED
[18:57:14.365] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:43:0) after 2m15s
[18:59:29.529] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:43:0)
[18:59:29.557] Build status: SCHEDULED
[18:59:29.557] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:44:0) after 1m2s
[19:00:31.622] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:44:0)
[19:00:31.698] Build status: SCHEDULED
[19:00:31.698] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:45:0) after 9m31s
[19:10:02.754] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:45:0)
[19:10:02.773] Build status: SCHEDULED
[19:10:02.773] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:46:0) after 4m14s
[19:14:16.797] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:46:0)
[19:14:16.820] Build status: SCHEDULED
[19:14:16.820] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:47:0) after 1m54s
[19:16:10.946] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:47:0)
[19:16:10.972] Build status: SCHEDULED
[19:16:10.972] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:48:0) after 5m20s
[19:21:31.006] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:48:0)
[19:21:31.031] Build status: SCHEDULED
[19:21:31.031] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:49:0) after 7m49s
[19:29:20.120] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:49:0)
[19:29:20.146] Build status: SCHEDULED
[19:29:20.146] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:50:0) after 3m29s
[19:32:49.230] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:50:0)
[19:32:49.253] Build status: SCHEDULED
[19:32:49.253] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:51:0) after 8m43s
[19:41:32.320] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:51:0)
[19:41:32.347] Build status: SCHEDULED
[19:41:32.347] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:52:0) after 3m6s
[19:44:38.366] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:52:0)
[19:44:38.446] Build status: SCHEDULED
[19:44:38.446] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:53:0) after 3m44s
[19:48:22.542] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:53:0)
[19:48:22.614] Build status: SCHEDULED
[19:48:22.614] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:54:0) after 3m1s
[19:51:23.894] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:54:0)
[19:51:23.913] Build status: SCHEDULED
[19:51:23.913] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:55:0) after 3m56s
[19:55:19.984] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:55:0)
[19:55:20.008] Build status: SCHEDULED
[19:55:20.008] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:56:0) after 5m5s
[20:00:25.006] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:56:0)
[20:00:25.049] Build status: SCHEDULED
[20:00:25.049] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:57:0) after 1m38s
[20:02:03.093] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:57:0)
[20:02:03.116] Build status: SCHEDULED
[20:02:03.116] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:58:0) after 3m57s
[20:06:00.131] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:58:0)
[20:06:00.165] Build status: SCHEDULED
[20:06:00.165] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:59:0) after 6m48s
[20:12:48.248] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:59:0)
[20:12:48.280] Build status: SCHEDULED
[20:12:48.280] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:60:0) after 8m37s
[20:21:25.304] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:60:0)
[20:21:25.364] Build status: SCHEDULED
[20:21:25.364] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:61:0) after 9m23s
[20:30:48.481] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:61:0)
[20:30:48.537] Build status: SCHEDULED
[20:30:48.537] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:62:0) after 5m36s
[20:36:24.730] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:62:0)
[20:36:24.750] Build status: SCHEDULED
[20:36:24.750] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:63:0) after 7m7s
[20:43:31.829] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:63:0)
[20:43:31.853] Build status: SCHEDULED
[20:43:31.853] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:64:0) after 7m53s
[20:51:24.876] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:64:0)
[20:51:24.900] Build status: SCHEDULED
[20:51:24.900] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:65:0) after 5m51s
[20:57:15.922] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:65:0)
[20:57:15.955] Build status: SCHEDULED
[20:57:15.955] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:66:0) after 9m6s
[21:06:21.983] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:66:0)
[21:06:22.004] Build status: SCHEDULED
[21:06:22.004] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:67:0) after 2m47s
[21:09:09.178] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:67:0)
[21:09:09.197] Build status: SCHEDULED
[21:09:09.197] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:68:0) after 4m49s
[21:13:58.299] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:68:0)
[21:13:58.366] Build status: SCHEDULED
[21:13:58.366] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:69:0) after 5m7s
[21:19:05.392] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:69:0)
[21:19:05.413] Build status: SCHEDULED
[21:19:05.413] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:70:0) after 8m33s
[21:27:38.550] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:70:0)
[21:27:38.569] Build status: SCHEDULED
[21:27:38.569] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:71:0) after 3m56s
[21:31:34.729] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:71:0)
[21:31:34.766] Build status: SCHEDULED
[21:31:34.766] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:72:0) after 6m43s
[21:38:18.174] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:72:0)
[21:38:18.201] Build status: SCHEDULED
[21:38:18.201] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:73:0) after 4m41s
[21:42:59.360] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:73:0)
[21:42:59.435] Build status: SCHEDULED
[21:42:59.436] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:74:0) after 2m34s
[21:45:33.585] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:74:0)
[21:45:33.607] Build status: SCHEDULED
[21:45:33.607] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:75:0) after 1m17s
[21:46:50.890] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:75:0)
[21:46:50.922] Build status: SCHEDULED
[21:46:50.922] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:76:0) after 9m50s
[21:56:40.991] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:76:0)
[21:56:41.011] Build status: SCHEDULED
[21:56:41.011] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:77:0) after 1m4s
[21:57:45.145] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:77:0)
[21:57:45.166] Build status: SCHEDULED
[21:57:45.166] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:78:0) after 9m21s
[22:07:06.198] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:78:0)
[22:07:06.227] Build status: SCHEDULED
[22:07:06.227] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:79:0) after 7m49s
[22:14:55.275] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:79:0)
[22:14:55.305] Build status: SCHEDULED
[22:14:55.305] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:80:0) after 1m23s
[22:16:18.454] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:80:0)
[22:16:18.483] Build status: SCHEDULED
[22:16:18.483] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:81:0) after 9m36s
[22:25:54.520] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:81:0)
[22:25:54.583] Build status: SCHEDULED
[22:25:54.584] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:82:0) after 9m11s
[22:35:05.681] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:82:0)
[22:35:05.765] Build status: SCHEDULED
[22:35:05.765] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:83:0) after 7m45s
[22:42:50.859] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:83:0)
[22:42:50.882] Build status: SCHEDULED
[22:42:50.882] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:84:0) after 3m56s
[22:46:46.886] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:84:0)
[22:46:46.916] Build status: SCHEDULED
[22:46:46.916] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:85:0) after 5m13s
[22:51:59.946] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:85:0)
[22:51:59.972] Build status: SCHEDULED
[22:51:59.972] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:86:0) after 9m36s
[23:01:35.990] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:86:0)
[23:01:36.020] Build status: SCHEDULED
[23:01:36.020] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:87:0) after 8m52s
[23:10:28.086] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:87:0)
[23:10:28.106] Build status: SCHEDULED
[23:10:28.106] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:88:0) after 5m33s
[23:16:01.154] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:88:0)
[23:16:01.184] Build status: SCHEDULED
[23:16:01.184] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:89:0) after 9m40s
[23:25:41.205] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:89:0)
[23:25:41.262] Build status: SCHEDULED
[23:25:41.262] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:90:0) after 7m13s
[23:32:54.458] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:90:0)
[23:32:54.482] Build status: SCHEDULED
[23:32:54.483] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:91:0) after 8m3s
[23:40:57.676] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:91:0)
[23:40:57.697] Build status: SCHEDULED
[23:40:57.697] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:92:0) after 1m53s
[23:42:50.769] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:92:0)
[23:42:50.789] Build status: SCHEDULED
[23:42:50.789] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:93:0) after 6m45s
[23:49:35.984] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:93:0)
[23:49:36.001] Build status: SCHEDULED
[23:49:36.002] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:94:0) after 6m7s
[23:55:43.148] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:94:0)
[23:55:43.177] Build status: SCHEDULED
[23:55:43.177] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:95:0) after 6m54s
[00:02:37.262] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:95:0)
[00:02:37.284] Build status: SCHEDULED
[00:02:37.285] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:96:0) after 8m21s
[00:10:58.446] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:96:0)
[00:10:58.470] Build status: SCHEDULED
[00:10:58.470] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:97:0) after 1m24s
[00:12:22.601] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:97:0)
[00:12:22.631] Build status: SCHEDULED
[00:12:22.631] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:98:0) after 3m38s
[00:16:00.832] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:98:0)
[00:16:00.898] Build status: SCHEDULED
[00:16:00.898] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:99:0) after 3m59s
[00:20:00.065] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:99:0)
[00:20:00.092] Build status: SCHEDULED
[00:20:00.092] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:100:0) after 2m9s
[00:22:09.199] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:100:0)
[00:22:09.227] Build status: SCHEDULED
[00:22:09.227] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:101:0) after 8m45s
[00:30:54.280] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:101:0)
[00:30:54.296] Build status: SCHEDULED
[00:30:54.296] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:102:0) after 6m21s
[00:37:15.310] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:102:0)
[00:37:15.352] Build status: SCHEDULED
[00:37:15.352] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:103:0) after 6m37s
[00:43:52.421] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:103:0)
[00:43:52.531] Build status: SCHEDULED
[00:43:52.531] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:104:0) after 7m25s
[00:51:17.814] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:104:0)
[00:51:17.844] Build status: SCHEDULED
[00:51:17.844] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:105:0) after 6m51s
[00:58:08.900] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:105:0)
[00:58:08.926] Build status: SCHEDULED
[00:58:08.926] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:106:0) after 4m58s
[01:03:06.937] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:106:0)
[01:03:06.956] Build status: SCHEDULED
[01:03:06.956] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:107:0) after 4m2s
[01:07:09.157] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:107:0)
[01:07:09.183] Build status: SCHEDULED
[01:07:09.183] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:108:0) after 3m23s
[01:10:32.200] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:108:0)
[01:10:32.327] Build status: SCHEDULED
[01:10:32.327] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:109:0) after 5m10s
[01:15:42.408] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:109:0)
[01:15:42.430] Build status: SCHEDULED
[01:15:42.430] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:110:0) after 5m23s
[01:21:05.443] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:110:0)
[01:21:05.473] Build status: SCHEDULED
[01:21:05.473] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:111:0) after 7m8s
[01:28:13.610] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:111:0)
[01:28:13.698] Build status: SCHEDULED
[01:28:13.698] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:112:0) after 3m11s
[01:31:24.766] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:112:0)
[01:31:24.793] Build status: SCHEDULED
[01:31:24.794] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:113:0) after 2m17s
[01:33:41.871] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:113:0)
[01:33:41.922] Build status: SCHEDULED
[01:33:41.922] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:114:0) after 4m33s
[01:38:14.939] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:114:0)
[01:38:14.983] Build status: SCHEDULED
[01:38:14.983] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:115:0) after 7m20s
[01:45:35.122] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:115:0)
[01:45:35.149] Build status: SCHEDULED
[01:45:35.149] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:116:0) after 1m32s
[01:47:07.178] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:116:0)
[01:47:07.237] Build status: SCHEDULED
[01:47:07.237] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:117:0) after 1m51s
[01:48:58.320] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:117:0)
[01:48:58.351] Build status: SCHEDULED
[01:48:58.352] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:118:0) after 8m13s
[01:57:11.368] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:118:0)
[01:57:11.393] Build status: SCHEDULED
[01:57:11.393] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:119:0) after 5m53s
[02:03:04.469] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:119:0)
[02:03:04.490] Build status: SCHEDULED
[02:03:04.490] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:120:0) after 2m12s
[02:05:16.508] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:120:0)
[02:05:16.531] Build status: SCHEDULED
[02:05:16.531] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:121:0) after 3m39s
[02:08:55.552] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:121:0)
[02:08:55.641] Build status: SCHEDULED
[02:08:55.641] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:122:0) after 9m26s
[02:18:21.680] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:122:0)
[02:18:21.700] Build status: SCHEDULED
[02:18:21.700] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:123:0) after 2m49s
[02:21:10.686] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:123:0)
[02:21:10.712] Build status: SCHEDULED
[02:21:10.712] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:124:0) after 4m21s
[02:25:31.802] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:124:0)
[02:25:31.820] Build status: SCHEDULED
[02:25:31.820] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:125:0) after 6m25s
[02:31:56.915] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:125:0)
[02:31:56.936] Build status: SCHEDULED
[02:31:56.936] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:126:0) after 4m41s
[02:36:38.122] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:126:0)
[02:36:38.141] Build status: SCHEDULED
[02:36:38.141] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:127:0) after 7m16s
[02:43:54.170] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:127:0)
[02:43:54.205] Build status: SCHEDULED
[02:43:54.205] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:128:0) after 2m25s
[02:46:19.322] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:128:0)
[02:46:19.340] Build status: SCHEDULED
[02:46:19.340] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:129:0) after 5m11s
[02:51:30.407] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:129:0)
[02:51:30.484] Build status: SCHEDULED
[02:51:30.484] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:130:0) after 4m29s
[02:55:59.905] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:130:0)
[02:55:59.932] Build status: SCHEDULED
[02:55:59.932] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:131:0) after 9m2s
[03:05:01.952] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:131:0)
[03:05:01.975] Build status: SCHEDULED
[03:05:01.975] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:132:0) after 8m51s
[03:13:52.960] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:132:0)
[03:13:52.983] Build status: SCHEDULED
[03:13:52.983] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:133:0) after 3m29s
[03:17:22.047] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:133:0)
[03:17:22.072] Build status: SCHEDULED
[03:17:22.072] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:134:0) after 3m10s
[03:20:32.042] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:134:0)
[03:20:32.087] Build status: SCHEDULED
[03:20:32.087] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:135:0) after 1m18s
[03:21:50.159] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:135:0)
[03:21:50.203] Build status: SCHEDULED
[03:21:50.203] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:136:0) after 3m4s
[03:24:54.298] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:136:0)
[03:24:54.329] Build status: SCHEDULED
[03:24:54.329] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:137:0) after 3m40s
[03:28:34.536] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:137:0)
[03:28:34.558] Build status: SCHEDULED
[03:28:34.558] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:138:0) after 7m54s
[03:36:28.573] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:138:0)
[03:36:28.707] Build status: SCHEDULED
[03:36:28.707] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:139:0) after 2m32s
[03:39:00.726] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:139:0)
[03:39:00.750] Build status: SCHEDULED
[03:39:00.750] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:140:0) after 7m6s
[03:46:06.763] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:140:0)
[03:46:06.779] Build status: SCHEDULED
[03:46:06.780] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:141:0) after 1m42s
[03:47:48.846] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:141:0)
[03:47:48.870] Build status: SCHEDULED
[03:47:48.870] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:142:0) after 3m47s
[03:51:35.944] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:142:0)
[03:51:35.962] Build status: SCHEDULED
[03:51:35.962] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:143:0) after 2m54s
[03:54:30.000] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:143:0)
[03:54:30.016] Build status: SCHEDULED
[03:54:30.016] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:144:0) after 3m45s
[03:58:15.015] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:144:0)
[03:58:15.105] Build status: SCHEDULED
[03:58:15.105] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:145:0) after 6m27s
[04:04:42.179] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:145:0)
[04:04:42.325] Build status: SCHEDULED
[04:04:42.325] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:146:0) after 8m18s
[04:13:00.345] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:146:0)
[04:13:00.372] Build status: SCHEDULED
[04:13:00.372] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:147:0) after 8m57s
[04:21:57.391] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:147:0)
[04:21:57.412] Build status: SCHEDULED
[04:21:57.412] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:148:0) after 1m36s
[04:23:33.478] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:148:0)
[04:23:33.501] Build status: SCHEDULED
[04:23:33.501] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:149:0) after 7m56s
[04:31:29.534] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:149:0)
[04:31:29.556] Build status: SCHEDULED
[04:31:29.556] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:150:0) after 6m35s
[04:38:04.541] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:150:0)
[04:38:04.623] Build status: SCHEDULED
[04:38:04.623] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:151:0) after 3m44s
[04:41:48.692] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:151:0)
[04:41:48.867] Build status: SCHEDULED
[04:41:48.867] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:152:0) after 4m40s
[04:46:28.883] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:152:0)
[04:46:28.976] Build status: SCHEDULED
[04:46:28.976] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:153:0) after 4m46s
[04:51:15.190] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:153:0)
[04:51:15.210] Build status: SCHEDULED
[04:51:15.210] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:154:0) after 2m18s
[04:53:33.261] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:154:0)
[04:53:33.340] Build status: SCHEDULED
[04:53:33.340] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:155:0) after 9m9s
[05:02:42.360] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:155:0)
[05:02:42.379] Build status: SCHEDULED
[05:02:42.379] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:156:0) after 4m25s
[05:07:07.398] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:156:0)
[05:07:07.431] Build status: SCHEDULED
[05:07:07.431] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:157:0) after 8m8s
[05:15:15.486] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:157:0)
[05:15:15.504] Build status: SCHEDULED
[05:15:15.505] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:158:0) after 9m7s
[05:18:05.247] Received PubSub notification, asking Buildbucket for the build status
[05:18:05.363] Build status: STARTED
[05:24:22.522] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:158:0)
[05:24:22.593] Build status: STARTED
[05:24:22.593] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:160:0) after 6m42s
[05:31:04.594] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:160:0)
[05:31:04.616] Build status: STARTED
[05:31:04.616] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:161:0) after 2m4s
[05:33:08.618] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:161:0)
[05:33:08.637] Build status: STARTED
[05:33:08.637] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:162:0) after 7m3s
[05:40:11.710] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:162:0)
[05:40:11.852] Build status: STARTED
[05:40:11.852] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:163:0) after 9m30s
[05:49:41.870] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:163:0)
[05:49:41.907] Build status: STARTED
[05:49:41.907] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:164:0) after 4m5s
[05:53:47.162] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:164:0)
[05:53:47.185] Build status: STARTED
[05:53:47.185] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:165:0) after 5m49s
[05:59:36.217] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:165:0)
[05:59:36.240] Build status: STARTED
[05:59:36.241] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:166:0) after 9m21s
[06:08:57.313] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:166:0)
[06:08:57.441] Build status: STARTED
[06:08:57.441] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:167:0) after 8m4s
[06:17:01.460] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:167:0)
[06:17:01.493] Build status: STARTED
[06:17:01.493] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:168:0) after 9m47s
[06:26:48.512] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:168:0)
[06:26:48.956] Build status: STARTED
[06:26:48.956] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:169:0) after 4m7s
[06:30:55.980] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:169:0)
[06:30:56.010] Build status: STARTED
[06:30:56.010] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:170:0) after 4m44s
[06:35:40.078] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:170:0)
[06:35:40.117] Build status: STARTED
[06:35:40.117] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:171:0) after 4m54s
[06:40:34.175] Handling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:171:0)
[06:40:34.204] Build status: STARTED
[06:40:34.204] Scheduling timer "check-buildbucket-build-status" (r8/perf:8834565782851313952:172:0) after 9m50s
[06:47:15.374] Received PubSub notification, asking Buildbucket for the build status
[06:47:15.503] Build:
{
"id": "8669135720571324577",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "perf"
},
"number": 3673,
"createdBy": "project:r8",
"createTime": "2026-10-01T14:29:00.059958575Z",
"startTime": "2026-10-02T05:18:04.888128274Z",
"endTime": "2026-10-02T06:47:14.566305857Z",
"updateTime": "2026-10-02T06:47:14.566305857Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "2602e187e5adc31ec1363443a61b7a8c9939cfa3",
"ref": "refs/heads/main"
}
}
}
[06:47:15.503] Invocation finished in 16h18m17.002173266s with status SUCCEEDED