[18:49:35.081] New invocation is queued and will start shortly
[18:49:36.474] Starting the invocation (attempt 1)
[18:49:36.511] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/3eb6988b4110560bf9a5a63b06d85462cecf5d46"
[18:49:36.511] Popped gitiles commit info from properties and tags
[18:49:36.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:49:36.511] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:49:36.511] Buildbucket request:
{
"requestId": "8991100944664955776",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/3.1",
"repo": "https://r8.googlesource.com/r8",
"revision": "3eb6988b4110560bf9a5a63b06d85462cecf5d46"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/3.1@3eb6988b4110560bf9a5a63b06d85462cecf5d46",
"title": "3eb6988b4110560bf9a5a63b06d85462cecf5d46",
"url": "https://r8.googlesource.com/r8/+/3eb6988b4110560bf9a5a63b06d85462cecf5d46"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "3eb6988b4110560bf9a5a63b06d85462cecf5d46",
"ref": "refs/heads/3.1"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8991100944664955776"
},
{
"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"
}
}
[18:49:37.106] Scheduled build:
{
"id": "8825670882426338097",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 565,
"createdBy": "project:r8",
"createTime": "2022-01-07T18:49:36.583564227Z",
"updateTime": "2022-01-07T18:49:36.583564227Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "3eb6988b4110560bf9a5a63b06d85462cecf5d46",
"ref": "refs/heads/3.1"
}
}
}
[18:49:37.106] Task URL: https://cr-buildbucket.appspot.com/build/8825670882426338097
[18:49:37.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:2:0) after 5m38s
[18:55:15.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:2:0)
[18:55:15.106] Build status: SCHEDULED
[18:55:15.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:3:0) after 1m38s
[18:56:53.167] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:3:0)
[18:56:53.197] Build status: SCHEDULED
[18:56:53.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:4:0) after 1m47s
[18:58:40.220] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:4:0)
[18:58:40.253] Build status: SCHEDULED
[18:58:40.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:5:0) after 8m23s
[19:07:03.272] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:5:0)
[19:07:03.307] Build status: SCHEDULED
[19:07:03.307] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:6:0) after 7m35s
[19:14:38.438] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:6:0)
[19:14:38.465] Build status: SCHEDULED
[19:14:38.465] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:7:0) after 3m44s
[19:18:22.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:7:0)
[19:18:22.629] Build status: SCHEDULED
[19:18:22.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:8:0) after 4m16s
[19:22:38.683] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:8:0)
[19:22:38.715] Build status: SCHEDULED
[19:22:38.715] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:9:0) after 5m44s
[19:28:22.902] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:9:0)
[19:28:22.937] Build status: SCHEDULED
[19:28:22.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:10:0) after 2m42s
[19:31:05.067] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:10:0)
[19:31:05.100] Build status: SCHEDULED
[19:31:05.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:11:0) after 9m38s
[19:40:43.386] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:11:0)
[19:40:43.414] Build status: SCHEDULED
[19:40:43.414] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:12:0) after 8m41s
[19:49:24.556] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:12:0)
[19:49:24.583] Build status: SCHEDULED
[19:49:24.583] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:13:0) after 7m57s
[19:57:21.605] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:13:0)
[19:57:21.642] Build status: SCHEDULED
[19:57:21.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:14:0) after 8m19s
[20:05:40.667] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:14:0)
[20:05:40.697] Build status: SCHEDULED
[20:05:40.697] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:15:0) after 4m59s
[20:10:39.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:15:0)
[20:10:39.822] Build status: SCHEDULED
[20:10:39.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:16:0) after 3m8s
[20:13:48.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:16:0)
[20:13:48.194] Build status: SCHEDULED
[20:13:48.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:17:0) after 2m36s
[20:16:24.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:17:0)
[20:16:24.459] Build status: SCHEDULED
[20:16:24.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:18:0) after 1m46s
[20:18:10.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:18:0)
[20:18:10.677] Build status: SCHEDULED
[20:18:10.677] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:19:0) after 4m18s
[20:22:29.005] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:19:0)
[20:22:29.031] Build status: SCHEDULED
[20:22:29.031] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:20:0) after 2m1s
[20:24:30.511] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:20:0)
[20:24:30.598] Build status: SCHEDULED
[20:24:30.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:21:0) after 4m55s
[20:29:25.619] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:21:0)
[20:29:25.649] Build status: SCHEDULED
[20:29:25.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:22:0) after 4m53s
[20:34:18.777] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:22:0)
[20:34:18.843] Build status: SCHEDULED
[20:34:18.843] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:23:0) after 4m15s
[20:38:34.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:23:0)
[20:38:34.119] Build status: SCHEDULED
[20:38:34.119] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:24:0) after 1m18s
[20:39:52.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:24:0)
[20:39:52.194] Build status: SCHEDULED
[20:39:52.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:25:0) after 8m45s
[20:48:37.213] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:25:0)
[20:48:37.245] Build status: SCHEDULED
[20:48:37.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:26:0) after 4m37s
[20:53:14.368] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:26:0)
[20:53:14.397] Build status: SCHEDULED
[20:53:14.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:27:0) after 8m13s
[21:01:27.518] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:27:0)
[21:01:27.558] Build status: SCHEDULED
[21:01:27.558] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:28:0) after 7m55s
[21:09:22.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:28:0)
[21:09:22.788] Build status: SCHEDULED
[21:09:22.788] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:29:0) after 1m56s
[21:11:18.979] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:29:0)
[21:11:19.013] Build status: SCHEDULED
[21:11:19.013] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:30:0) after 5m17s
[21:16:36.029] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:30:0)
[21:16:36.065] Build status: SCHEDULED
[21:16:36.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:31:0) after 4m47s
[21:21:23.096] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:31:0)
[21:21:23.130] Build status: SCHEDULED
[21:21:23.130] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:32:0) after 8m52s
[21:30:15.145] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:32:0)
[21:30:15.258] Build status: SCHEDULED
[21:30:15.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:33:0) after 7m36s
[21:37:51.343] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:33:0)
[21:37:51.375] Build status: SCHEDULED
[21:37:51.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:34:0) after 2m30s
[21:40:21.394] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:34:0)
[21:40:21.428] Build status: SCHEDULED
[21:40:21.428] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:35:0) after 5m53s
[21:46:14.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:35:0)
[21:46:14.695] Build status: SCHEDULED
[21:46:14.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:36:0) after 1m29s
[21:47:44.138] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:36:0)
[21:47:44.169] Build status: SCHEDULED
[21:47:44.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:37:0) after 2m26s
[21:50:10.190] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:37:0)
[21:50:10.410] Build status: SCHEDULED
[21:50:10.410] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:38:0) after 3m17s
[21:53:27.523] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:38:0)
[21:53:27.591] Build status: SCHEDULED
[21:53:27.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:39:0) after 2m31s
[21:55:58.755] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:39:0)
[21:55:58.786] Build status: SCHEDULED
[21:55:58.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:40:0) after 1m42s
[21:57:40.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:40:0)
[21:57:40.820] Build status: SCHEDULED
[21:57:40.820] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:41:0) after 6m22s
[22:04:02.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:41:0)
[22:04:03.027] Build status: SCHEDULED
[22:04:03.027] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:42:0) after 5m26s
[22:09:29.158] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:42:0)
[22:09:29.189] Build status: SCHEDULED
[22:09:29.189] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:43:0) after 1m45s
[22:11:15.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:43:0)
[22:11:15.118] Build status: SCHEDULED
[22:11:15.118] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:44:0) after 3m26s
[22:14:41.259] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:44:0)
[22:14:41.292] Build status: SCHEDULED
[22:14:41.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:45:0) after 8m10s
[22:22:51.313] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:45:0)
[22:22:51.342] Build status: SCHEDULED
[22:22:51.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:46:0) after 6m24s
[22:29:15.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:46:0)
[22:29:15.717] Build status: SCHEDULED
[22:29:15.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:47:0) after 5m42s
[22:34:57.915] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:47:0)
[22:34:57.937] Build status: SCHEDULED
[22:34:57.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:48:0) after 7m48s
[22:42:46.069] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:48:0)
[22:42:46.101] Build status: SCHEDULED
[22:42:46.101] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:49:0) after 6m14s
[22:49:00.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:49:0)
[22:49:00.286] Build status: SCHEDULED
[22:49:00.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:50:0) after 5m48s
[22:54:48.375] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:50:0)
[22:54:48.409] Build status: SCHEDULED
[22:54:48.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:51:0) after 2m6s
[22:56:54.520] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:51:0)
[22:56:54.548] Build status: SCHEDULED
[22:56:54.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:52:0) after 2m56s
[22:59:50.669] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:52:0)
[22:59:50.697] Build status: SCHEDULED
[22:59:50.697] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:53:0) after 4m10s
[23:04:00.915] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:53:0)
[23:04:00.948] Build status: SCHEDULED
[23:04:00.948] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:54:0) after 1m36s
[23:05:37.072] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:54:0)
[23:05:37.131] Build status: SCHEDULED
[23:05:37.131] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:55:0) after 3m17s
[23:08:54.308] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:55:0)
[23:08:54.337] Build status: SCHEDULED
[23:08:54.337] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:56:0) after 1m37s
[23:10:31.607] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:56:0)
[23:10:31.633] Build status: SCHEDULED
[23:10:31.633] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:57:0) after 8m29s
[23:19:00.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:57:0)
[23:19:00.865] Build status: SCHEDULED
[23:19:00.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:58:0) after 2m6s
[23:21:06.890] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:58:0)
[23:21:06.921] Build status: SCHEDULED
[23:21:06.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:59:0) after 6m59s
[23:28:05.896] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:59:0)
[23:28:05.928] Build status: SCHEDULED
[23:28:05.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:60:0) after 3m11s
[23:31:17.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:60:0)
[23:31:17.281] Build status: SCHEDULED
[23:31:17.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:61:0) after 8m4s
[23:39:21.318] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:61:0)
[23:39:21.349] Build status: SCHEDULED
[23:39:21.349] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:62:0) after 1m22s
[23:40:43.369] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:62:0)
[23:40:43.451] Build status: SCHEDULED
[23:40:43.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:63:0) after 4m23s
[23:45:06.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:63:0)
[23:45:06.527] Build status: SCHEDULED
[23:45:06.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:64:0) after 4m8s
[23:49:14.545] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:64:0)
[23:49:14.577] Build status: SCHEDULED
[23:49:14.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:65:0) after 5m34s
[23:54:48.597] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:65:0)
[23:54:48.639] Build status: SCHEDULED
[23:54:48.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:66:0) after 7m2s
[00:01:50.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:66:0)
[00:01:50.696] Build status: SCHEDULED
[00:01:50.696] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:67:0) after 7m48s
[00:09:38.668] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:67:0)
[00:09:38.703] Build status: SCHEDULED
[00:09:38.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:68:0) after 2m23s
[00:12:02.188] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:68:0)
[00:12:02.224] Build status: SCHEDULED
[00:12:02.224] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:69:0) after 4m55s
[00:16:57.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:69:0)
[00:16:57.389] Build status: SCHEDULED
[00:16:57.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:70:0) after 8m35s
[00:21:18.335] Received PubSub notification, asking Buildbucket for the build status
[00:21:18.366] Build status: STARTED
[00:25:32.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:70:0)
[00:25:32.522] Build status: STARTED
[00:25:32.522] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:72:0) after 4m40s
[00:30:12.976] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:72:0)
[00:30:13.015] Build status: STARTED
[00:30:13.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:73:0) after 2m28s
[00:32:41.169] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:73:0)
[00:32:41.385] Build status: STARTED
[00:32:41.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:74:0) after 4m23s
[00:37:04.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:74:0)
[00:37:04.436] Build status: STARTED
[00:37:04.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:75:0) after 9m24s
[00:46:28.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:75:0)
[00:46:28.571] Build status: STARTED
[00:46:28.571] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:76:0) after 6m30s
[00:52:58.594] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:76:0)
[00:52:58.660] Build status: STARTED
[00:52:58.660] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:77:0) after 8m2s
[01:01:00.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:77:0)
[01:01:00.710] Build status: STARTED
[01:01:00.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:78:0) after 8m17s
[01:09:17.798] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:78:0)
[01:09:17.830] Build status: STARTED
[01:09:17.830] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:79:0) after 3m30s
[01:12:47.966] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:79:0)
[01:12:48.002] Build status: STARTED
[01:12:48.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:80:0) after 6m19s
[01:19:07.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:80:0)
[01:19:07.071] Build status: STARTED
[01:19:07.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:81:0) after 4m57s
[01:24:04.171] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:81:0)
[01:24:04.214] Build status: STARTED
[01:24:04.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:82:0) after 7m26s
[01:31:30.478] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:82:0)
[01:31:30.506] Build status: STARTED
[01:31:30.506] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:83:0) after 7m12s
[01:38:42.733] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:83:0)
[01:38:42.787] Build status: STARTED
[01:38:42.787] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:84:0) after 7m44s
[01:46:26.860] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:84:0)
[01:46:26.951] Build status: STARTED
[01:46:26.951] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:85:0) after 7m2s
[01:53:29.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:85:0)
[01:53:29.102] Build status: STARTED
[01:53:29.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:86:0) after 6m34s
[02:00:03.203] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:86:0)
[02:00:03.231] Build status: STARTED
[02:00:03.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:87:0) after 7m14s
[02:07:17.216] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:87:0)
[02:07:17.246] Build status: STARTED
[02:07:17.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:88:0) after 2m35s
[02:09:52.374] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:88:0)
[02:09:52.403] Build status: STARTED
[02:09:52.403] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:89:0) after 6m34s
[02:16:26.578] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:89:0)
[02:16:26.607] Build status: STARTED
[02:16:26.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:90:0) after 4m46s
[02:21:12.634] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:90:0)
[02:21:12.682] Build status: STARTED
[02:21:12.682] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:91:0) after 9m29s
[02:30:41.705] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:91:0)
[02:30:41.739] Build status: STARTED
[02:30:41.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:92:0) after 7m13s
[02:37:54.756] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:92:0)
[02:37:54.829] Build status: STARTED
[02:37:54.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:93:0) after 5m24s
[02:43:18.852] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:93:0)
[02:43:18.889] Build status: STARTED
[02:43:18.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:94:0) after 4m50s
[02:48:09.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:94:0)
[02:48:09.197] Build status: STARTED
[02:48:09.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:95:0) after 8m23s
[02:56:32.218] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:95:0)
[02:56:32.247] Build status: STARTED
[02:56:32.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:96:0) after 9m33s
[03:06:05.476] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:96:0)
[03:06:05.507] Build status: STARTED
[03:06:05.507] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:97:0) after 7m52s
[03:13:57.563] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:97:0)
[03:13:57.592] Build status: STARTED
[03:13:57.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:98:0) after 1m32s
[03:15:29.677] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:98:0)
[03:15:29.714] Build status: STARTED
[03:15:29.714] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:99:0) after 8m30s
[03:23:59.739] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:99:0)
[03:23:59.768] Build status: STARTED
[03:23:59.768] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:100:0) after 5m28s
[03:29:27.846] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:100:0)
[03:29:27.888] Build status: STARTED
[03:29:27.888] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:101:0) after 4m44s
[03:34:11.909] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:101:0)
[03:34:11.965] Build status: STARTED
[03:34:11.965] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:102:0) after 9m13s
[03:43:25.092] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:102:0)
[03:43:25.123] Build status: STARTED
[03:43:25.123] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:103:0) after 3m41s
[03:47:06.126] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:103:0)
[03:47:06.299] Build status: STARTED
[03:47:06.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:104:0) after 2m0s
[03:49:06.504] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:104:0)
[03:49:06.537] Build status: STARTED
[03:49:06.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:105:0) after 9m59s
[03:59:05.580] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:105:0)
[03:59:05.621] Build status: STARTED
[03:59:05.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:106:0) after 9m56s
[04:09:01.673] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:106:0)
[04:09:01.707] Build status: STARTED
[04:09:01.707] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:107:0) after 1m10s
[04:10:11.767] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:107:0)
[04:10:11.804] Build status: STARTED
[04:10:11.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:108:0) after 9m3s
[04:19:14.831] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:108:0)
[04:19:14.863] Build status: STARTED
[04:19:14.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:109:0) after 8m56s
[04:28:10.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:109:0)
[04:28:10.926] Build status: STARTED
[04:28:10.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:110:0) after 9m20s
[04:37:31.003] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:110:0)
[04:37:31.034] Build status: STARTED
[04:37:31.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:111:0) after 2m16s
[04:39:47.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:111:0)
[04:39:47.141] Build status: STARTED
[04:39:47.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:112:0) after 8m34s
[04:48:21.168] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:112:0)
[04:48:21.203] Build status: STARTED
[04:48:21.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:113:0) after 2m10s
[04:50:31.234] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:113:0)
[04:50:31.269] Build status: STARTED
[04:50:31.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:114:0) after 9m13s
[04:59:44.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:114:0)
[04:59:44.570] Build status: STARTED
[04:59:44.570] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:115:0) after 3m9s
[05:02:53.746] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:115:0)
[05:02:53.788] Build status: STARTED
[05:02:53.788] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:116:0) after 4m47s
[05:07:40.877] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:116:0)
[05:07:40.907] Build status: STARTED
[05:07:40.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:117:0) after 7m26s
[05:15:08.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:117:0)
[05:15:08.181] Build status: STARTED
[05:15:08.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:118:0) after 1m51s
[05:16:59.224] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:118:0)
[05:16:59.252] Build status: STARTED
[05:16:59.252] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:119:0) after 4m6s
[05:21:05.356] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:119:0)
[05:21:05.385] Build status: STARTED
[05:21:05.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:120:0) after 9m47s
[05:30:53.469] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:120:0)
[05:30:53.499] Build status: STARTED
[05:30:53.499] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:121:0) after 7m6s
[05:37:59.542] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:121:0)
[05:37:59.591] Build status: STARTED
[05:37:59.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:122:0) after 5m21s
[05:43:20.616] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:122:0)
[05:43:20.662] Build status: STARTED
[05:43:20.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:123:0) after 1m25s
[05:44:45.670] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:123:0)
[05:44:45.705] Build status: STARTED
[05:44:45.705] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:124:0) after 3m0s
[05:47:45.727] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:124:0)
[05:47:45.755] Build status: STARTED
[05:47:45.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:125:0) after 9m8s
[05:56:53.744] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:125:0)
[05:56:53.780] Build status: STARTED
[05:56:53.780] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:126:0) after 5m17s
[06:02:10.829] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:126:0)
[06:02:10.858] Build status: STARTED
[06:02:10.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:127:0) after 1m37s
[06:03:47.885] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:127:0)
[06:03:47.909] Build status: STARTED
[06:03:47.909] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:128:0) after 8m19s
[06:12:07.015] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:128:0)
[06:12:07.059] Build status: STARTED
[06:12:07.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:129:0) after 9m12s
[06:21:19.086] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:129:0)
[06:21:19.125] Build status: STARTED
[06:21:19.125] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:130:0) after 7m16s
[06:28:35.152] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:130:0)
[06:28:35.183] Build status: STARTED
[06:28:35.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:131:0) after 9m52s
[06:38:27.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:131:0)
[06:38:27.234] Build status: STARTED
[06:38:27.234] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:132:0) after 5m52s
[06:44:19.364] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:132:0)
[06:44:19.387] Build status: STARTED
[06:44:19.387] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:133:0) after 2m10s
[06:46:29.387] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:133:0)
[06:46:29.422] Build status: STARTED
[06:46:29.422] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:134:0) after 2m9s
[06:48:38.539] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:134:0)
[06:48:38.573] Build status: STARTED
[06:48:38.573] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:135:0) after 8m20s
[06:56:58.796] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:135:0)
[06:56:58.829] Build status: STARTED
[06:56:58.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:136:0) after 5m46s
[07:02:44.872] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:136:0)
[07:02:44.902] Build status: STARTED
[07:02:44.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:137:0) after 4m14s
[07:06:58.936] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:137:0)
[07:06:59.002] Build status: STARTED
[07:06:59.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:138:0) after 3m58s
[07:10:57.116] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:138:0)
[07:10:57.152] Build status: STARTED
[07:10:57.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:139:0) after 4m8s
[07:15:05.276] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:139:0)
[07:15:05.304] Build status: STARTED
[07:15:05.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:140:0) after 6m36s
[07:21:41.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:140:0)
[07:21:41.700] Build status: STARTED
[07:21:41.700] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:141:0) after 2m43s
[07:24:24.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:141:0)
[07:24:24.792] Build status: STARTED
[07:24:24.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:142:0) after 1m28s
[07:25:52.956] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:142:0)
[07:25:52.988] Build status: STARTED
[07:25:52.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:143:0) after 2m52s
[07:28:45.149] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:143:0)
[07:28:45.177] Build status: STARTED
[07:28:45.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:144:0) after 9m58s
[07:38:43.235] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:144:0)
[07:38:43.267] Build status: STARTED
[07:38:43.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:145:0) after 2m22s
[07:41:05.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:145:0)
[07:41:05.492] Build status: STARTED
[07:41:05.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:146:0) after 5m13s
[07:46:18.561] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:146:0)
[07:46:18.607] Build status: STARTED
[07:46:18.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:147:0) after 8m13s
[07:54:31.612] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:147:0)
[07:54:31.911] Build status: STARTED
[07:54:31.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:148:0) after 8m17s
[08:02:48.946] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:148:0)
[08:02:48.994] Build status: STARTED
[08:02:48.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:149:0) after 9m5s
[08:11:54.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:149:0)
[08:11:54.187] Build status: STARTED
[08:11:54.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:150:0) after 9m37s
[08:21:31.283] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:150:0)
[08:21:31.315] Build status: STARTED
[08:21:31.315] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:151:0) after 5m40s
[08:27:11.463] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:151:0)
[08:27:11.483] Build status: STARTED
[08:27:11.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:152:0) after 1m18s
[08:28:29.489] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:152:0)
[08:28:29.510] Build status: STARTED
[08:28:29.510] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:153:0) after 3m35s
[08:32:04.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:153:0)
[08:32:04.568] Build status: STARTED
[08:32:04.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:154:0) after 4m22s
[08:36:26.619] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:154:0)
[08:36:26.652] Build status: STARTED
[08:36:26.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:155:0) after 8m13s
[08:44:39.677] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:155:0)
[08:44:39.704] Build status: STARTED
[08:44:39.704] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:156:0) after 3m52s
[08:48:31.878] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:156:0)
[08:48:31.913] Build status: STARTED
[08:48:31.913] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:157:0) after 7m9s
[08:55:41.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:157:0)
[08:55:41.104] Build status: STARTED
[08:55:41.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:158:0) after 3m36s
[08:59:17.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:158:0)
[08:59:17.205] Build status: STARTED
[08:59:17.205] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:159:0) after 3m9s
[09:02:26.227] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:159:0)
[09:02:26.247] Build status: STARTED
[09:02:26.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:160:0) after 1m42s
[09:04:08.481] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:160:0)
[09:04:08.526] Build status: STARTED
[09:04:08.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:161:0) after 5m7s
[09:09:15.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:161:0)
[09:09:15.612] Build status: STARTED
[09:09:15.612] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:162:0) after 2m3s
[09:11:18.644] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:162:0)
[09:11:18.686] Build status: STARTED
[09:11:18.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:163:0) after 3m37s
[09:14:55.715] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:163:0)
[09:14:55.766] Build status: STARTED
[09:14:55.766] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:164:0) after 1m46s
[09:16:41.793] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:164:0)
[09:16:41.825] Build status: STARTED
[09:16:41.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:165:0) after 6m48s
[09:23:29.992] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:165:0)
[09:23:30.023] Build status: STARTED
[09:23:30.023] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:166:0) after 7m49s
[09:31:19.028] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:166:0)
[09:31:19.065] Build status: STARTED
[09:31:19.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:167:0) after 1m47s
[09:33:06.095] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:167:0)
[09:33:06.165] Build status: STARTED
[09:33:06.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:168:0) after 1m24s
[09:34:30.453] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:168:0)
[09:34:30.483] Build status: STARTED
[09:34:30.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:169:0) after 1m37s
[09:36:07.672] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:169:0)
[09:36:07.700] Build status: STARTED
[09:36:07.700] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:170:0) after 1m59s
[09:38:06.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:170:0)
[09:38:06.898] Build status: STARTED
[09:38:06.898] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:171:0) after 9m33s
[09:47:40.018] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:171:0)
[09:47:40.040] Build status: STARTED
[09:47:40.040] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:172:0) after 9m11s
[09:56:51.887] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:172:0)
[09:56:51.922] Build status: STARTED
[09:56:51.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:173:0) after 8m34s
[10:05:25.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:173:0)
[10:05:25.996] Build status: STARTED
[10:05:25.996] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:174:0) after 9m27s
[10:14:53.710] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:174:0)
[10:14:53.739] Build status: STARTED
[10:14:53.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:175:0) after 9m8s
[10:24:01.768] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:175:0)
[10:24:01.806] Build status: STARTED
[10:24:01.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:176:0) after 8m41s
[10:32:42.821] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:176:0)
[10:32:42.843] Build status: STARTED
[10:32:42.843] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:177:0) after 9m41s
[10:42:23.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:177:0)
[10:42:23.905] Build status: STARTED
[10:42:23.905] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:178:0) after 1m40s
[10:44:03.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:178:0)
[10:44:03.966] Build status: STARTED
[10:44:03.966] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:179:0) after 8m19s
[10:52:22.990] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:179:0)
[10:52:23.026] Build status: STARTED
[10:52:23.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:180:0) after 2m13s
[10:54:36.050] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:180:0)
[10:54:36.077] Build status: STARTED
[10:54:36.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:181:0) after 1m10s
[10:55:46.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:181:0)
[10:55:47.020] Build status: STARTED
[10:55:47.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:182:0) after 2m8s
[10:57:55.070] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:182:0)
[10:57:55.116] Build status: STARTED
[10:57:55.116] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:183:0) after 7m14s
[11:05:09.243] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:183:0)
[11:05:09.364] Build status: STARTED
[11:05:09.364] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:184:0) after 2m35s
[11:07:44.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:184:0)
[11:07:44.409] Build status: STARTED
[11:07:44.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:185:0) after 6m33s
[11:14:17.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:185:0)
[11:14:17.622] Build status: STARTED
[11:14:17.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:186:0) after 4m12s
[11:18:30.001] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:186:0)
[11:18:30.165] Build status: STARTED
[11:18:30.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:187:0) after 4m36s
[11:23:06.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:187:0)
[11:23:06.299] Build status: STARTED
[11:23:06.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:188:0) after 2m6s
[11:25:12.607] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:188:0)
[11:25:12.634] Build status: STARTED
[11:25:12.634] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:189:0) after 8m34s
[11:33:46.958] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:189:0)
[11:33:46.999] Build status: STARTED
[11:33:46.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:190:0) after 5m55s
[11:39:42.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:190:0)
[11:39:42.051] Build status: STARTED
[11:39:42.051] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:191:0) after 9m32s
[11:49:14.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:191:0)
[11:49:14.122] Build status: STARTED
[11:49:14.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:192:0) after 2m16s
[11:51:30.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:192:0)
[11:51:30.215] Build status: STARTED
[11:51:30.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:193:0) after 6m22s
[11:57:52.240] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:193:0)
[11:57:52.267] Build status: STARTED
[11:57:52.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:194:0) after 3m18s
[12:01:10.286] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:194:0)
[12:01:10.319] Build status: STARTED
[12:01:10.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:195:0) after 9m34s
[12:10:44.631] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:195:0)
[12:10:44.660] Build status: STARTED
[12:10:44.660] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:196:0) after 8m48s
[12:19:32.684] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:196:0)
[12:19:32.716] Build status: STARTED
[12:19:32.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8991100944664955776:197:0) after 6m28s
[12:21:38.914] Received PubSub notification, asking Buildbucket for the build status
[12:21:38.945] Build:
{
"id": "8825670882426338097",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 565,
"createdBy": "project:r8",
"createTime": "2022-01-07T18:49:36.583564227Z",
"startTime": "2022-01-08T00:21:17.372153Z",
"endTime": "2022-01-08T12:21:38.524375776Z",
"updateTime": "2022-01-08T12:21:38.524375776Z",
"status": "FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "3eb6988b4110560bf9a5a63b06d85462cecf5d46",
"ref": "refs/heads/3.1"
}
}
}
[12:21:38.945] Invocation finished in 17h32m3.879407774s with status FAILED