[13:38:28.676] New invocation is queued and will start shortly
[13:38:29.725] Starting the invocation (attempt 1)
[13:38:29.749] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/8cf7bf9dbec1c4342b26d0201a8ade999f21443a"
[13:38:29.749] Popped gitiles commit info from properties and tags
[13:38:29.749] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:38:29.749] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:38:29.750] Buildbucket request:
{
"requestId": "8937396516724792272",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8937396516724792272",
"job": "r8/linux-internal_release",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/8.2",
"repo": "https://r8.googlesource.com/r8",
"revision": "8cf7bf9dbec1c4342b26d0201a8ade999f21443a"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/8.2@8cf7bf9dbec1c4342b26d0201a8ade999f21443a",
"title": "8cf7bf9dbec1c4342b26d0201a8ade999f21443a",
"url": "https://r8.googlesource.com/r8/+/8cf7bf9dbec1c4342b26d0201a8ade999f21443a"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8cf7bf9dbec1c4342b26d0201a8ade999f21443a",
"ref": "refs/heads/8.2"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8937396516724792272"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-internal_release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:38:30.348] Scheduled build:
{
"id": "8771966454861458609",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 956,
"createdBy": "project:r8",
"createTime": "2023-08-23T13:38:29.829209280Z",
"updateTime": "2023-08-23T13:38:29.829209280Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8cf7bf9dbec1c4342b26d0201a8ade999f21443a",
"ref": "refs/heads/8.2"
}
}
}
[13:38:30.348] Task URL: https://cr-buildbucket.appspot.com/build/8771966454861458609
[13:38:30.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:2:0) after 5m52s
[13:38:31.256] Received PubSub notification, asking Buildbucket for the build status
[13:38:31.330] Build status: SCHEDULED
[13:44:22.378] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:2:0)
[13:44:22.418] Build status: SCHEDULED
[13:44:22.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:4:0) after 5m20s
[13:49:42.448] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:4:0)
[13:49:42.472] Build status: SCHEDULED
[13:49:42.472] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:5:0) after 8m1s
[13:57:43.628] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:5:0)
[13:57:43.669] Build status: SCHEDULED
[13:57:43.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:6:0) after 3m34s
[14:01:17.944] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:6:0)
[14:01:17.988] Build status: SCHEDULED
[14:01:17.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:7:0) after 9m45s
[14:11:03.042] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:7:0)
[14:11:03.077] Build status: SCHEDULED
[14:11:03.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:8:0) after 6m27s
[14:17:30.201] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:8:0)
[14:17:30.224] Build status: SCHEDULED
[14:17:30.224] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:9:0) after 1m50s
[14:19:20.242] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:9:0)
[14:19:20.266] Build status: SCHEDULED
[14:19:20.266] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:10:0) after 1m38s
[14:20:58.298] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:10:0)
[14:20:58.320] Build status: SCHEDULED
[14:20:58.320] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:11:0) after 5m53s
[14:26:51.577] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:11:0)
[14:26:51.596] Build status: SCHEDULED
[14:26:51.596] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:12:0) after 5m12s
[14:32:03.850] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:12:0)
[14:32:03.885] Build status: SCHEDULED
[14:32:03.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:13:0) after 2m27s
[14:34:30.981] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:13:0)
[14:34:30.998] Build status: SCHEDULED
[14:34:30.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:14:0) after 5m54s
[14:40:25.056] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:14:0)
[14:40:25.089] Build status: SCHEDULED
[14:40:25.089] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:15:0) after 7m25s
[14:47:50.369] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:15:0)
[14:47:50.402] Build status: SCHEDULED
[14:47:50.402] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:16:0) after 4m47s
[14:52:37.478] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:16:0)
[14:52:37.496] Build status: SCHEDULED
[14:52:37.496] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:17:0) after 2m4s
[14:54:42.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:17:0)
[14:54:42.142] Build status: SCHEDULED
[14:54:42.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:18:0) after 5m33s
[15:00:15.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:18:0)
[15:00:15.237] Build status: SCHEDULED
[15:00:15.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:19:0) after 1m33s
[15:01:48.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:19:0)
[15:01:48.338] Build status: SCHEDULED
[15:01:48.338] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:20:0) after 7m9s
[15:08:57.669] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:20:0)
[15:08:57.689] Build status: SCHEDULED
[15:08:57.689] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:21:0) after 3m7s
[15:12:04.814] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:21:0)
[15:12:04.852] Build status: SCHEDULED
[15:12:04.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:22:0) after 6m53s
[15:18:57.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:22:0)
[15:18:57.974] Build status: SCHEDULED
[15:18:57.974] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:23:0) after 7m42s
[15:26:40.002] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:23:0)
[15:26:40.028] Build status: SCHEDULED
[15:26:40.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:24:0) after 1m47s
[15:28:27.250] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:24:0)
[15:28:27.269] Build status: SCHEDULED
[15:28:27.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:25:0) after 3m26s
[15:31:53.361] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:25:0)
[15:31:53.381] Build status: SCHEDULED
[15:31:53.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:26:0) after 1m18s
[15:33:11.497] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:26:0)
[15:33:11.520] Build status: SCHEDULED
[15:33:11.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:27:0) after 7m54s
[15:41:05.933] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:27:0)
[15:41:05.951] Build status: SCHEDULED
[15:41:05.951] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:28:0) after 1m32s
[15:42:38.061] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:28:0)
[15:42:38.219] Build status: SCHEDULED
[15:42:38.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:29:0) after 4m49s
[15:47:27.660] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:29:0)
[15:47:27.687] Build status: SCHEDULED
[15:47:27.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:30:0) after 3m4s
[15:50:31.804] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:30:0)
[15:50:31.839] Build status: SCHEDULED
[15:50:31.839] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:31:0) after 9m12s
[15:59:43.854] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:31:0)
[15:59:43.985] Build status: SCHEDULED
[15:59:43.985] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:32:0) after 4m35s
[16:04:19.244] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:32:0)
[16:04:19.270] Build status: SCHEDULED
[16:04:19.270] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:33:0) after 6m40s
[16:10:59.617] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:33:0)
[16:10:59.723] Build status: SCHEDULED
[16:10:59.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:34:0) after 9m55s
[16:20:55.200] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:34:0)
[16:20:55.229] Build status: SCHEDULED
[16:20:55.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:35:0) after 5m50s
[16:26:45.245] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:35:0)
[16:26:45.327] Build status: SCHEDULED
[16:26:45.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:36:0) after 5m45s
[16:32:30.841] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:36:0)
[16:32:30.860] Build status: SCHEDULED
[16:32:30.860] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:37:0) after 3m40s
[16:36:10.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:37:0)
[16:36:10.875] Build status: SCHEDULED
[16:36:10.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:38:0) after 5m15s
[16:41:26.222] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:38:0)
[16:41:26.269] Build status: SCHEDULED
[16:41:26.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:39:0) after 4m43s
[16:46:09.294] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:39:0)
[16:46:09.325] Build status: SCHEDULED
[16:46:09.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:40:0) after 5m29s
[16:51:38.316] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:40:0)
[16:51:38.342] Build status: SCHEDULED
[16:51:38.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:41:0) after 3m5s
[16:54:43.374] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:41:0)
[16:54:43.394] Build status: SCHEDULED
[16:54:43.394] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:42:0) after 3m50s
[16:58:33.400] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:42:0)
[16:58:33.422] Build status: SCHEDULED
[16:58:33.422] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:43:0) after 7m55s
[17:06:28.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:43:0)
[17:06:28.472] Build status: SCHEDULED
[17:06:28.472] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:44:0) after 3m5s
[17:09:33.487] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:44:0)
[17:09:33.515] Build status: SCHEDULED
[17:09:33.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:45:0) after 1m46s
[17:11:19.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:45:0)
[17:11:19.566] Build status: SCHEDULED
[17:11:19.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:46:0) after 8m20s
[17:19:39.590] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:46:0)
[17:19:39.607] Build status: SCHEDULED
[17:19:39.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:47:0) after 7m28s
[17:27:07.626] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:47:0)
[17:27:07.789] Build status: SCHEDULED
[17:27:07.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:48:0) after 6m19s
[17:33:26.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:48:0)
[17:33:26.978] Build status: SCHEDULED
[17:33:26.978] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:49:0) after 5m6s
[17:38:33.043] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:49:0)
[17:38:33.072] Build status: SCHEDULED
[17:38:33.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:50:0) after 3m31s
[17:42:04.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:50:0)
[17:42:04.162] Build status: SCHEDULED
[17:42:04.162] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:51:0) after 5m54s
[17:47:58.231] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:51:0)
[17:47:58.266] Build status: SCHEDULED
[17:47:58.266] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:52:0) after 2m11s
[17:50:09.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:52:0)
[17:50:09.325] Build status: SCHEDULED
[17:50:09.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:53:0) after 6m49s
[17:56:58.348] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:53:0)
[17:56:58.371] Build status: SCHEDULED
[17:56:58.371] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:54:0) after 9m24s
[18:06:22.406] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:54:0)
[18:06:22.446] Build status: SCHEDULED
[18:06:22.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:55:0) after 9m25s
[18:15:47.579] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:55:0)
[18:15:47.611] Build status: SCHEDULED
[18:15:47.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:56:0) after 5m47s
[18:21:34.833] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:56:0)
[18:21:35.005] Build status: SCHEDULED
[18:21:35.005] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:57:0) after 6m19s
[18:27:54.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:57:0)
[18:27:54.086] Build status: SCHEDULED
[18:27:54.086] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:58:0) after 1m12s
[18:29:06.314] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:58:0)
[18:29:06.334] Build status: SCHEDULED
[18:29:06.334] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:59:0) after 2m12s
[18:31:18.352] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:59:0)
[18:31:18.413] Build status: SCHEDULED
[18:31:18.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:60:0) after 3m44s
[18:35:02.442] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:60:0)
[18:35:02.463] Build status: SCHEDULED
[18:35:02.463] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:61:0) after 6m12s
[18:41:14.765] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:61:0)
[18:41:14.783] Build status: SCHEDULED
[18:41:14.783] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:62:0) after 9m51s
[18:51:05.799] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:62:0)
[18:51:05.821] Build status: SCHEDULED
[18:51:05.821] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:63:0) after 7m23s
[18:58:28.939] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:63:0)
[18:58:28.957] Build status: SCHEDULED
[18:58:28.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:64:0) after 2m51s
[19:01:19.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:64:0)
[19:01:19.992] Build status: SCHEDULED
[19:01:19.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:65:0) after 7m34s
[19:08:54.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:65:0)
[19:08:54.025] Build status: SCHEDULED
[19:08:54.025] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:66:0) after 9m46s
[19:18:40.092] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:66:0)
[19:18:40.149] Build status: SCHEDULED
[19:18:40.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:67:0) after 1m28s
[19:20:08.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:67:0)
[19:20:08.226] Build status: SCHEDULED
[19:20:08.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:68:0) after 4m58s
[19:25:06.245] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:68:0)
[19:25:06.281] Build status: SCHEDULED
[19:25:06.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:69:0) after 5m36s
[19:30:42.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:69:0)
[19:30:42.816] Build status: SCHEDULED
[19:30:42.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:70:0) after 4m47s
[19:35:29.880] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:70:0)
[19:35:29.975] Build status: SCHEDULED
[19:35:29.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:71:0) after 3m7s
[19:38:37.114] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:71:0)
[19:38:37.133] Build status: SCHEDULED
[19:38:37.133] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:72:0) after 5m44s
[19:44:21.173] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:72:0)
[19:44:21.209] Build status: SCHEDULED
[19:44:21.209] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:73:0) after 8m32s
[19:52:55.754] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:73:0)
[19:52:55.772] Build status: SCHEDULED
[19:52:55.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:74:0) after 4m15s
[19:57:10.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:74:0)
[19:57:10.775] Build status: SCHEDULED
[19:57:10.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:75:0) after 9m46s
[20:06:56.795] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:75:0)
[20:06:56.865] Build status: SCHEDULED
[20:06:56.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:76:0) after 4m48s
[20:11:44.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:76:0)
[20:11:44.928] Build status: SCHEDULED
[20:11:44.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:77:0) after 1m56s
[20:13:41.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:77:0)
[20:13:41.180] Build status: SCHEDULED
[20:13:41.180] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:78:0) after 3m6s
[20:16:47.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:78:0)
[20:16:47.546] Build status: SCHEDULED
[20:16:47.546] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:79:0) after 4m21s
[20:21:10.111] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:79:0)
[20:21:10.133] Build status: SCHEDULED
[20:21:10.133] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:80:0) after 2m42s
[20:23:52.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:80:0)
[20:23:52.455] Build status: SCHEDULED
[20:23:52.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:81:0) after 4m45s
[20:28:37.480] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:81:0)
[20:28:37.513] Build status: SCHEDULED
[20:28:37.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:82:0) after 7m26s
[20:36:03.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:82:0)
[20:36:03.628] Build status: SCHEDULED
[20:36:03.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:83:0) after 4m32s
[20:40:35.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:83:0)
[20:40:35.768] Build status: SCHEDULED
[20:40:35.768] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:84:0) after 8m2s
[20:48:37.836] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:84:0)
[20:48:37.866] Build status: SCHEDULED
[20:48:37.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:85:0) after 6m30s
[20:55:07.882] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:85:0)
[20:55:07.915] Build status: SCHEDULED
[20:55:07.915] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:86:0) after 3m10s
[20:58:17.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:86:0)
[20:58:18.020] Build status: SCHEDULED
[20:58:18.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:87:0) after 2m27s
[21:00:45.077] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:87:0)
[21:00:45.146] Build status: SCHEDULED
[21:00:45.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:88:0) after 4m58s
[21:05:43.263] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:88:0)
[21:05:43.291] Build status: SCHEDULED
[21:05:43.291] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:89:0) after 1m56s
[21:07:39.308] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:89:0)
[21:07:39.326] Build status: SCHEDULED
[21:07:39.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:90:0) after 5m10s
[21:12:50.280] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:90:0)
[21:12:50.361] Build status: SCHEDULED
[21:12:50.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:91:0) after 9m42s
[21:22:32.474] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:91:0)
[21:22:32.508] Build status: SCHEDULED
[21:22:32.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:92:0) after 2m27s
[21:24:59.574] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:92:0)
[21:24:59.617] Build status: SCHEDULED
[21:24:59.617] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:93:0) after 7m57s
[21:32:57.391] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:93:0)
[21:32:57.414] Build status: SCHEDULED
[21:32:57.414] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:94:0) after 8m47s
[21:41:44.669] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:94:0)
[21:41:44.702] Build status: SCHEDULED
[21:41:44.702] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:95:0) after 8m11s
[21:49:55.839] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:95:0)
[21:49:55.865] Build status: SCHEDULED
[21:49:55.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:96:0) after 4m56s
[21:54:51.882] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:96:0)
[21:54:51.901] Build status: SCHEDULED
[21:54:51.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:97:0) after 8m10s
[22:03:01.917] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:97:0)
[22:03:01.955] Build status: SCHEDULED
[22:03:01.955] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:98:0) after 4m58s
[22:07:59.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:98:0)
[22:08:00.032] Build status: SCHEDULED
[22:08:00.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:99:0) after 3m47s
[22:11:47.043] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:99:0)
[22:11:47.117] Build status: SCHEDULED
[22:11:47.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:100:0) after 8m21s
[22:20:09.394] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:100:0)
[22:20:09.419] Build status: SCHEDULED
[22:20:09.419] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:101:0) after 8m20s
[22:28:29.417] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:101:0)
[22:28:29.452] Build status: SCHEDULED
[22:28:29.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:102:0) after 4m21s
[22:32:50.813] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:102:0)
[22:32:50.855] Build status: SCHEDULED
[22:32:50.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:103:0) after 7m25s
[22:40:15.882] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:103:0)
[22:40:15.945] Build status: SCHEDULED
[22:40:15.945] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:104:0) after 4m33s
[22:44:49.648] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:104:0)
[22:44:49.666] Build status: SCHEDULED
[22:44:49.666] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:105:0) after 5m35s
[22:50:24.687] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:105:0)
[22:50:24.716] Build status: SCHEDULED
[22:50:24.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:106:0) after 1m19s
[22:51:43.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:106:0)
[22:51:43.886] Build status: SCHEDULED
[22:51:43.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:107:0) after 9m25s
[23:01:09.590] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:107:0)
[23:01:09.619] Build status: SCHEDULED
[23:01:09.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:108:0) after 7m32s
[23:08:41.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:108:0)
[23:08:41.683] Build status: SCHEDULED
[23:08:41.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:109:0) after 2m11s
[23:10:53.060] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:109:0)
[23:10:53.081] Build status: SCHEDULED
[23:10:53.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:110:0) after 4m33s
[23:15:26.078] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:110:0)
[23:15:26.111] Build status: SCHEDULED
[23:15:26.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:111:0) after 6m43s
[23:22:09.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:111:0)
[23:22:09.266] Build status: SCHEDULED
[23:22:09.266] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:112:0) after 6m48s
[23:28:57.283] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:112:0)
[23:28:57.742] Build status: SCHEDULED
[23:28:57.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:113:0) after 5m34s
[23:34:31.759] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:113:0)
[23:34:31.790] Build status: SCHEDULED
[23:34:31.790] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:114:0) after 1m33s
[23:36:04.898] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:114:0)
[23:36:04.934] Build status: SCHEDULED
[23:36:04.934] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:115:0) after 8m44s
[23:44:49.001] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:115:0)
[23:44:49.019] Build status: SCHEDULED
[23:44:49.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:116:0) after 5m49s
[23:50:38.211] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:116:0)
[23:50:38.238] Build status: SCHEDULED
[23:50:38.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:117:0) after 9m38s
[00:00:16.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:117:0)
[00:00:16.465] Build status: SCHEDULED
[00:00:16.465] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:118:0) after 3m42s
[00:03:58.694] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:118:0)
[00:03:58.719] Build status: SCHEDULED
[00:03:58.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:119:0) after 3m30s
[00:07:29.273] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:119:0)
[00:07:29.316] Build status: SCHEDULED
[00:07:29.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:120:0) after 3m29s
[00:10:58.345] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:120:0)
[00:10:58.384] Build status: SCHEDULED
[00:10:58.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:121:0) after 5m22s
[00:16:20.718] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:121:0)
[00:16:20.751] Build status: SCHEDULED
[00:16:20.751] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:122:0) after 6m41s
[00:23:01.805] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:122:0)
[00:23:01.840] Build status: SCHEDULED
[00:23:01.840] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:123:0) after 1m36s
[00:24:38.067] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:123:0)
[00:24:38.086] Build status: SCHEDULED
[00:24:38.086] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:124:0) after 5m25s
[00:30:03.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:124:0)
[00:30:03.302] Build status: SCHEDULED
[00:30:03.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:125:0) after 6m47s
[00:36:50.692] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:125:0)
[00:36:50.709] Build status: SCHEDULED
[00:36:50.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:126:0) after 9m54s
[00:46:44.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:126:0)
[00:46:44.812] Build status: SCHEDULED
[00:46:44.812] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:127:0) after 9m22s
[00:56:06.905] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:127:0)
[00:56:07.019] Build status: SCHEDULED
[00:56:07.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:128:0) after 3m17s
[00:59:24.036] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:128:0)
[00:59:24.076] Build status: SCHEDULED
[00:59:24.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:129:0) after 5m6s
[01:04:30.177] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:129:0)
[01:04:30.262] Build status: SCHEDULED
[01:04:30.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:130:0) after 9m32s
[01:14:02.370] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:130:0)
[01:14:04.413] Build status: SCHEDULED
[01:14:04.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:131:0) after 1m58s
[01:16:03.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:131:0)
[01:16:03.072] Build status: SCHEDULED
[01:16:03.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:132:0) after 7m50s
[01:23:53.184] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:132:0)
[01:23:53.225] Build status: SCHEDULED
[01:23:53.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:133:0) after 1m44s
[01:25:37.241] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:133:0)
[01:25:37.264] Build status: SCHEDULED
[01:25:37.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:134:0) after 8m5s
[01:33:43.021] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:134:0)
[01:33:43.056] Build status: SCHEDULED
[01:33:43.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:135:0) after 2m54s
[01:36:37.078] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:135:0)
[01:36:37.132] Build status: SCHEDULED
[01:36:37.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:136:0) after 4m45s
[01:39:53.497] Received PubSub notification, asking Buildbucket for the build status
[01:39:53.529] Build status: STARTED
[01:41:22.285] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:136:0)
[01:41:22.370] Build status: STARTED
[01:41:22.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:138:0) after 6m36s
[01:47:58.490] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:138:0)
[01:47:58.510] Build status: STARTED
[01:47:58.510] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:139:0) after 4m27s
[01:52:25.529] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:139:0)
[01:52:25.562] Build status: STARTED
[01:52:25.562] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:140:0) after 5m20s
[01:57:45.787] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:140:0)
[01:57:45.807] Build status: STARTED
[01:57:45.807] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:141:0) after 7m24s
[02:05:09.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:141:0)
[02:05:10.232] Build status: STARTED
[02:05:10.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:142:0) after 5m39s
[02:10:49.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:142:0)
[02:10:49.278] Build status: STARTED
[02:10:49.278] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:143:0) after 6m37s
[02:17:26.314] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:143:0)
[02:17:26.343] Build status: STARTED
[02:17:26.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:144:0) after 7m35s
[02:25:01.470] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:144:0)
[02:25:01.515] Build status: STARTED
[02:25:01.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:145:0) after 1m1s
[02:26:02.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:145:0)
[02:26:02.574] Build status: STARTED
[02:26:02.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:146:0) after 7m12s
[02:33:14.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:146:0)
[02:33:14.674] Build status: STARTED
[02:33:14.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:147:0) after 1m39s
[02:34:53.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:147:0)
[02:34:53.818] Build status: STARTED
[02:34:53.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:148:0) after 3m32s
[02:38:25.874] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:148:0)
[02:38:25.910] Build status: STARTED
[02:38:25.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:149:0) after 4m29s
[02:42:54.932] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:149:0)
[02:42:54.953] Build status: STARTED
[02:42:54.953] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:150:0) after 7m50s
[02:50:44.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:150:0)
[02:50:45.001] Build status: STARTED
[02:50:45.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:151:0) after 1m2s
[02:51:47.026] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:151:0)
[02:51:47.163] Build status: STARTED
[02:51:47.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:152:0) after 5m41s
[02:57:28.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:152:0)
[02:57:28.568] Build status: STARTED
[02:57:28.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:153:0) after 3m42s
[03:01:10.590] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:153:0)
[03:01:10.621] Build status: STARTED
[03:01:10.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:154:0) after 7m10s
[03:08:20.805] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:154:0)
[03:08:20.963] Build status: STARTED
[03:08:20.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:155:0) after 2m1s
[03:10:22.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:155:0)
[03:10:22.242] Build status: STARTED
[03:10:22.242] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:156:0) after 8m11s
[03:18:33.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:156:0)
[03:18:33.678] Build status: STARTED
[03:18:33.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:157:0) after 6m27s
[03:25:00.789] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:157:0)
[03:25:00.819] Build status: STARTED
[03:25:00.819] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:158:0) after 2m27s
[03:27:27.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:158:0)
[03:27:27.896] Build status: STARTED
[03:27:27.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:159:0) after 4m14s
[03:31:42.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:159:0)
[03:31:42.091] Build status: STARTED
[03:31:42.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:160:0) after 5m10s
[03:36:52.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:160:0)
[03:36:52.288] Build status: STARTED
[03:36:52.288] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:161:0) after 9m48s
[03:46:40.370] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:161:0)
[03:46:40.406] Build status: STARTED
[03:46:40.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:162:0) after 7m33s
[03:54:13.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:162:0)
[03:54:13.448] Build status: STARTED
[03:54:13.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:163:0) after 9m22s
[04:03:35.470] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:163:0)
[04:03:35.515] Build status: STARTED
[04:03:35.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:164:0) after 6m19s
[04:09:54.532] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:164:0)
[04:09:54.602] Build status: STARTED
[04:09:54.602] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:165:0) after 5m14s
[04:15:08.666] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:165:0)
[04:15:08.687] Build status: STARTED
[04:15:08.688] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:166:0) after 8m15s
[04:23:23.809] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:166:0)
[04:23:23.852] Build status: STARTED
[04:23:23.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:167:0) after 9m39s
[04:33:02.869] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:167:0)
[04:33:02.899] Build status: STARTED
[04:33:02.899] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:168:0) after 5m41s
[04:38:44.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:168:0)
[04:38:44.675] Build status: STARTED
[04:38:44.675] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:169:0) after 9m23s
[04:48:07.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:169:0)
[04:48:07.861] Build status: STARTED
[04:48:07.861] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:170:0) after 7m53s
[04:56:00.928] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:170:0)
[04:56:00.964] Build status: STARTED
[04:56:00.964] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:171:0) after 9m21s
[05:05:22.126] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:171:0)
[05:05:22.148] Build status: STARTED
[05:05:22.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:172:0) after 4m14s
[05:09:36.183] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:172:0)
[05:09:36.203] Build status: STARTED
[05:09:36.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:173:0) after 4m43s
[05:14:19.192] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:173:0)
[05:14:19.212] Build status: STARTED
[05:14:19.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:174:0) after 6m0s
[05:20:19.348] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:174:0)
[05:20:19.381] Build status: STARTED
[05:20:19.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:175:0) after 4m42s
[05:25:01.692] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:175:0)
[05:25:01.724] Build status: STARTED
[05:25:01.724] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:176:0) after 8m34s
[05:33:35.784] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:176:0)
[05:33:35.813] Build status: STARTED
[05:33:35.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:177:0) after 7m59s
[05:41:34.833] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:177:0)
[05:41:34.866] Build status: STARTED
[05:41:34.866] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:178:0) after 7m8s
[05:48:42.939] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:178:0)
[05:48:42.957] Build status: STARTED
[05:48:42.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:179:0) after 6m50s
[05:55:33.007] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:179:0)
[05:55:33.035] Build status: STARTED
[05:55:33.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:180:0) after 9m51s
[06:05:24.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:180:0)
[06:05:24.149] Build status: STARTED
[06:05:24.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:181:0) after 3m20s
[06:08:44.154] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:181:0)
[06:08:44.186] Build status: STARTED
[06:08:44.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:182:0) after 5m55s
[06:14:39.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:182:0)
[06:14:39.306] Build status: STARTED
[06:14:39.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:183:0) after 8m56s
[06:23:35.405] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:183:0)
[06:23:35.602] Build status: STARTED
[06:23:35.602] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:184:0) after 5m51s
[06:29:26.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:184:0)
[06:29:26.744] Build status: STARTED
[06:29:26.744] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:185:0) after 5m49s
[06:35:15.859] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:185:0)
[06:35:15.893] Build status: STARTED
[06:35:15.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:186:0) after 1m28s
[06:36:43.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:186:0)
[06:36:43.996] Build status: STARTED
[06:36:43.996] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:187:0) after 6m13s
[06:42:57.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:187:0)
[06:42:57.042] Build status: STARTED
[06:42:57.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:188:0) after 6m17s
[06:49:14.059] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:188:0)
[06:49:14.085] Build status: STARTED
[06:49:14.085] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:189:0) after 6m24s
[06:55:38.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:189:0)
[06:55:38.131] Build status: STARTED
[06:55:38.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:190:0) after 7m57s
[07:03:35.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:190:0)
[07:03:35.218] Build status: STARTED
[07:03:35.218] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:191:0) after 3m57s
[07:07:32.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:191:0)
[07:07:32.519] Build status: STARTED
[07:07:32.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:192:0) after 9m49s
[07:17:21.664] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:192:0)
[07:17:21.721] Build status: STARTED
[07:17:21.721] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8937396516724792272:193:0) after 5m57s
[07:21:25.431] Received PubSub notification, asking Buildbucket for the build status
[07:21:25.447] Build:
{
"id": "8771966454861458609",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 956,
"createdBy": "project:r8",
"createTime": "2023-08-23T13:38:29.829209280Z",
"startTime": "2023-08-24T01:39:52.964382Z",
"endTime": "2023-08-24T07:21:25.098550599Z",
"updateTime": "2023-08-24T07:21:25.098550599Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8cf7bf9dbec1c4342b26d0201a8ade999f21443a",
"ref": "refs/heads/8.2"
}
}
}
[07:21:25.447] Invocation finished in 17h42m56.779028222s with status FAILED