[11:54:18.362] New invocation is queued and will start shortly
[11:54:19.445] Starting the invocation (attempt 1)
[11:54:19.511] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/fdf08281f38e89d338032bc747a48d2393f8de7d"
[11:54:19.511] Popped gitiles commit info from properties and tags
[11:54:19.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:54:19.511] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:54:19.511] Buildbucket request:
{
"requestId": "8997106471519392416",
"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": "fdf08281f38e89d338032bc747a48d2393f8de7d"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/3.1@fdf08281f38e89d338032bc747a48d2393f8de7d",
"title": "fdf08281f38e89d338032bc747a48d2393f8de7d",
"url": "https://r8.googlesource.com/r8/+/fdf08281f38e89d338032bc747a48d2393f8de7d"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "fdf08281f38e89d338032bc747a48d2393f8de7d",
"ref": "refs/heads/3.1"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8997106471519392416"
},
{
"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"
}
}
[11:54:20.075] Scheduled build:
{
"id": "8831676409570988849",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 525,
"createdBy": "project:r8",
"createTime": "2021-11-02T11:54:19.589806420Z",
"updateTime": "2021-11-02T11:54:19.589806420Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "fdf08281f38e89d338032bc747a48d2393f8de7d",
"ref": "refs/heads/3.1"
}
}
}
[11:54:20.076] Task URL: https://cr-buildbucket.appspot.com/build/8831676409570988849
[11:54:20.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:2:0) after 5m37s
[11:59:57.097] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:2:0)
[11:59:57.126] Build status: SCHEDULED
[11:59:57.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:3:0) after 3m39s
[12:03:36.397] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:3:0)
[12:03:36.479] Build status: SCHEDULED
[12:03:36.479] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:4:0) after 2m13s
[12:05:49.496] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:4:0)
[12:05:49.531] Build status: SCHEDULED
[12:05:49.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:5:0) after 2m27s
[12:08:16.547] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:5:0)
[12:08:16.573] Build status: SCHEDULED
[12:08:16.573] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:6:0) after 1m27s
[12:09:43.627] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:6:0)
[12:09:43.697] Build status: SCHEDULED
[12:09:43.697] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:7:0) after 5m35s
[12:15:18.717] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:7:0)
[12:15:18.751] Build status: SCHEDULED
[12:15:18.751] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:8:0) after 8m25s
[12:23:43.953] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:8:0)
[12:23:44.000] Build status: SCHEDULED
[12:23:44.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:9:0) after 9m47s
[12:33:31.133] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:9:0)
[12:33:31.171] Build status: SCHEDULED
[12:33:31.171] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:10:0) after 5m59s
[12:39:30.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:10:0)
[12:39:30.569] Build status: SCHEDULED
[12:39:30.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:11:0) after 4m22s
[12:43:52.586] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:11:0)
[12:43:52.618] Build status: SCHEDULED
[12:43:52.618] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:12:0) after 4m59s
[12:48:51.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:12:0)
[12:48:51.666] Build status: SCHEDULED
[12:48:51.666] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:13:0) after 5m3s
[12:53:54.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:13:0)
[12:53:54.717] Build status: SCHEDULED
[12:53:54.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:14:0) after 5m4s
[12:58:58.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:14:0)
[12:58:58.957] Build status: SCHEDULED
[12:58:58.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:15:0) after 6m57s
[13:05:56.084] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:15:0)
[13:05:56.120] Build status: SCHEDULED
[13:05:56.120] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:16:0) after 4m13s
[13:10:09.112] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:16:0)
[13:10:09.162] Build status: SCHEDULED
[13:10:09.162] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:17:0) after 1m21s
[13:11:30.175] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:17:0)
[13:11:30.212] Build status: SCHEDULED
[13:11:30.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:18:0) after 2m58s
[13:14:28.241] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:18:0)
[13:14:28.274] Build status: SCHEDULED
[13:14:28.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:19:0) after 2m25s
[13:16:53.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:19:0)
[13:16:53.347] Build status: SCHEDULED
[13:16:53.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:20:0) after 3m25s
[13:20:18.464] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:20:0)
[13:20:18.510] Build status: SCHEDULED
[13:20:18.510] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:21:0) after 7m30s
[13:27:48.629] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:21:0)
[13:27:48.658] Build status: SCHEDULED
[13:27:48.658] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:22:0) after 1m5s
[13:28:53.691] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:22:0)
[13:28:53.725] Build status: SCHEDULED
[13:28:53.725] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:23:0) after 7m46s
[13:36:39.785] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:23:0)
[13:36:39.816] Build status: SCHEDULED
[13:36:39.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:24:0) after 3m18s
[13:39:57.889] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:24:0)
[13:39:57.919] Build status: SCHEDULED
[13:39:57.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:25:0) after 6m9s
[13:46:06.935] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:25:0)
[13:46:06.968] Build status: SCHEDULED
[13:46:06.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:26:0) after 4m53s
[13:50:59.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:26:0)
[13:51:00.017] Build status: SCHEDULED
[13:51:00.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:27:0) after 1m31s
[13:52:31.034] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:27:0)
[13:52:31.084] Build status: SCHEDULED
[13:52:31.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:28:0) after 8m58s
[14:01:29.136] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:28:0)
[14:01:29.167] Build status: SCHEDULED
[14:01:29.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:29:0) after 5m28s
[14:06:57.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:29:0)
[14:06:57.224] Build status: SCHEDULED
[14:06:57.224] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:30:0) after 4m47s
[14:11:44.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:30:0)
[14:11:44.391] Build status: SCHEDULED
[14:11:44.391] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:31:0) after 3m30s
[14:15:14.420] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:31:0)
[14:15:14.470] Build status: SCHEDULED
[14:15:14.470] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:32:0) after 5m37s
[14:20:51.586] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:32:0)
[14:20:51.618] Build status: SCHEDULED
[14:20:51.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:33:0) after 7m27s
[14:28:18.637] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:33:0)
[14:28:18.672] Build status: SCHEDULED
[14:28:18.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:34:0) after 5m22s
[14:33:40.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:34:0)
[14:33:40.680] Build status: SCHEDULED
[14:33:40.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:35:0) after 2m23s
[14:36:03.709] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:35:0)
[14:36:03.742] Build status: SCHEDULED
[14:36:03.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:36:0) after 1m40s
[14:37:43.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:36:0)
[14:37:43.789] Build status: SCHEDULED
[14:37:43.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:37:0) after 8m49s
[14:46:32.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:37:0)
[14:46:32.865] Build status: SCHEDULED
[14:46:32.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:38:0) after 7m54s
[14:54:26.888] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:38:0)
[14:54:26.925] Build status: SCHEDULED
[14:54:26.925] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:39:0) after 4m54s
[14:59:21.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:39:0)
[14:59:21.036] Build status: SCHEDULED
[14:59:21.036] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:40:0) after 8m41s
[15:08:02.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:40:0)
[15:08:02.096] Build status: SCHEDULED
[15:08:02.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:41:0) after 2m29s
[15:10:31.177] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:41:0)
[15:10:31.230] Build status: SCHEDULED
[15:10:31.230] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:42:0) after 7m10s
[15:17:41.250] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:42:0)
[15:17:41.294] Build status: SCHEDULED
[15:17:41.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:43:0) after 2m12s
[15:19:53.419] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:43:0)
[15:19:53.482] Build status: SCHEDULED
[15:19:53.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:44:0) after 1m9s
[15:21:02.560] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:44:0)
[15:21:02.663] Build status: SCHEDULED
[15:21:02.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:45:0) after 2m47s
[15:23:50.364] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:45:0)
[15:23:50.396] Build status: SCHEDULED
[15:23:50.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:46:0) after 4m27s
[15:28:17.416] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:46:0)
[15:28:17.447] Build status: SCHEDULED
[15:28:17.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:47:0) after 8m57s
[15:37:14.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:47:0)
[15:37:14.531] Build status: SCHEDULED
[15:37:14.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:48:0) after 8m54s
[15:46:08.642] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:48:0)
[15:46:08.687] Build status: SCHEDULED
[15:46:08.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:49:0) after 5m53s
[15:52:01.852] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:49:0)
[15:52:01.893] Build status: SCHEDULED
[15:52:01.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:50:0) after 4m19s
[15:56:21.109] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:50:0)
[15:56:21.135] Build status: SCHEDULED
[15:56:21.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:51:0) after 8m15s
[16:04:36.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:51:0)
[16:04:36.215] Build status: SCHEDULED
[16:04:36.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:52:0) after 1m53s
[16:06:29.234] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:52:0)
[16:06:29.276] Build status: SCHEDULED
[16:06:29.276] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:53:0) after 4m32s
[16:11:01.569] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:53:0)
[16:11:01.611] Build status: SCHEDULED
[16:11:01.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:54:0) after 4m0s
[16:15:01.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:54:0)
[16:15:01.778] Build status: SCHEDULED
[16:15:01.778] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:55:0) after 5m10s
[16:20:11.834] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:55:0)
[16:20:11.877] Build status: SCHEDULED
[16:20:11.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:56:0) after 8m3s
[16:28:14.897] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:56:0)
[16:28:14.959] Build status: SCHEDULED
[16:28:14.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:57:0) after 8m12s
[16:36:26.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:57:0)
[16:36:27.092] Build status: SCHEDULED
[16:36:27.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:58:0) after 1m57s
[16:38:24.366] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:58:0)
[16:38:24.400] Build status: SCHEDULED
[16:38:24.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:59:0) after 4m15s
[16:42:39.572] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:59:0)
[16:42:39.607] Build status: SCHEDULED
[16:42:39.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:60:0) after 7m9s
[16:49:48.820] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:60:0)
[16:49:48.868] Build status: SCHEDULED
[16:49:48.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:61:0) after 1m48s
[16:51:37.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:61:0)
[16:51:37.132] Build status: SCHEDULED
[16:51:37.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:62:0) after 1m10s
[16:52:47.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:62:0)
[16:52:47.165] Build status: SCHEDULED
[16:52:47.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:63:0) after 5m58s
[16:58:45.213] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:63:0)
[16:58:45.264] Build status: SCHEDULED
[16:58:45.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:64:0) after 4m22s
[17:03:07.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:64:0)
[17:03:07.405] Build status: SCHEDULED
[17:03:07.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:65:0) after 6m0s
[17:09:07.922] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:65:0)
[17:09:07.969] Build status: SCHEDULED
[17:09:07.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:66:0) after 1m15s
[17:10:23.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:66:0)
[17:10:23.044] Build status: SCHEDULED
[17:10:23.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:67:0) after 4m34s
[17:14:57.200] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:67:0)
[17:14:57.233] Build status: SCHEDULED
[17:14:57.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:68:0) after 4m13s
[17:19:10.263] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:68:0)
[17:19:10.298] Build status: SCHEDULED
[17:19:10.298] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:69:0) after 9m57s
[17:29:07.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:69:0)
[17:29:07.382] Build status: SCHEDULED
[17:29:07.382] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:70:0) after 7m13s
[17:36:20.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:70:0)
[17:36:20.656] Build status: SCHEDULED
[17:36:20.656] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:71:0) after 1m50s
[17:38:10.677] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:71:0)
[17:38:10.706] Build status: SCHEDULED
[17:38:10.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:72:0) after 3m49s
[17:42:00.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:72:0)
[17:42:00.468] Build status: SCHEDULED
[17:42:00.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:73:0) after 1m30s
[17:43:30.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:73:0)
[17:43:30.512] Build status: SCHEDULED
[17:43:30.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:74:0) after 7m42s
[17:51:12.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:74:0)
[17:51:13.123] Build status: SCHEDULED
[17:51:13.123] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:75:0) after 6m49s
[17:58:02.291] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:75:0)
[17:58:02.331] Build status: SCHEDULED
[17:58:02.331] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:76:0) after 9m7s
[18:07:09.451] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:76:0)
[18:07:09.485] Build status: SCHEDULED
[18:07:09.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:77:0) after 3m34s
[18:10:43.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:77:0)
[18:10:43.578] Build status: SCHEDULED
[18:10:43.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:78:0) after 1m57s
[18:12:40.710] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:78:0)
[18:12:40.763] Build status: SCHEDULED
[18:12:40.763] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:79:0) after 1m33s
[18:14:14.387] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:79:0)
[18:14:14.420] Build status: SCHEDULED
[18:14:14.420] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:80:0) after 6m11s
[18:20:25.754] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:80:0)
[18:20:25.798] Build status: SCHEDULED
[18:20:25.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:81:0) after 2m14s
[18:22:39.824] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:81:0)
[18:22:39.872] Build status: SCHEDULED
[18:22:39.872] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:82:0) after 6m7s
[18:28:46.894] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:82:0)
[18:28:46.927] Build status: SCHEDULED
[18:28:46.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:83:0) after 6m5s
[18:34:52.053] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:83:0)
[18:34:52.088] Build status: SCHEDULED
[18:34:52.088] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:84:0) after 7m59s
[18:42:51.109] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:84:0)
[18:42:51.136] Build status: SCHEDULED
[18:42:51.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:85:0) after 1m19s
[18:44:10.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:85:0)
[18:44:10.193] Build status: SCHEDULED
[18:44:10.193] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:86:0) after 4m52s
[18:49:02.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:86:0)
[18:49:02.212] Build status: SCHEDULED
[18:49:02.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:87:0) after 5m52s
[18:54:54.231] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:87:0)
[18:54:54.262] Build status: SCHEDULED
[18:54:54.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:88:0) after 1m44s
[18:56:38.294] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:88:0)
[18:56:38.323] Build status: SCHEDULED
[18:56:38.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:89:0) after 1m31s
[18:58:09.355] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:89:0)
[18:58:09.393] Build status: SCHEDULED
[18:58:09.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:90:0) after 9m9s
[19:07:18.417] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:90:0)
[19:07:18.447] Build status: SCHEDULED
[19:07:18.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:91:0) after 1m29s
[19:08:47.732] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:91:0)
[19:08:47.766] Build status: SCHEDULED
[19:08:47.766] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:92:0) after 6m24s
[19:15:11.912] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:92:0)
[19:15:11.948] Build status: SCHEDULED
[19:15:11.948] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:93:0) after 1m47s
[19:16:58.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:93:0)
[19:16:59.053] Build status: SCHEDULED
[19:16:59.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:94:0) after 5m54s
[19:22:53.087] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:94:0)
[19:22:53.122] Build status: SCHEDULED
[19:22:53.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:95:0) after 4m21s
[19:27:14.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:95:0)
[19:27:14.283] Build status: SCHEDULED
[19:27:14.283] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:96:0) after 3m38s
[19:30:52.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:96:0)
[19:30:52.394] Build status: SCHEDULED
[19:30:52.394] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:97:0) after 1m14s
[19:32:06.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:97:0)
[19:32:06.638] Build status: SCHEDULED
[19:32:06.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:98:0) after 9m18s
[19:41:24.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:98:0)
[19:41:24.754] Build status: SCHEDULED
[19:41:24.754] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:99:0) after 7m18s
[19:43:36.270] Received PubSub notification, asking Buildbucket for the build status
[19:43:36.297] Build status: STARTED
[19:48:42.778] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:99:0)
[19:48:42.816] Build status: STARTED
[19:48:42.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:101:0) after 1m7s
[19:49:49.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:101:0)
[19:49:50.020] Build status: STARTED
[19:49:50.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:102:0) after 2m51s
[19:52:41.203] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:102:0)
[19:52:41.236] Build status: STARTED
[19:52:41.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:103:0) after 3m41s
[19:56:22.234] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:103:0)
[19:56:22.382] Build status: STARTED
[19:56:22.382] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:104:0) after 3m35s
[19:59:57.503] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:104:0)
[19:59:57.553] Build status: STARTED
[19:59:57.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:105:0) after 5m41s
[20:05:38.778] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:105:0)
[20:05:38.812] Build status: STARTED
[20:05:38.812] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:106:0) after 3m52s
[20:09:30.817] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:106:0)
[20:09:30.863] Build status: STARTED
[20:09:30.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:107:0) after 4m42s
[20:14:12.995] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:107:0)
[20:14:13.053] Build status: STARTED
[20:14:13.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:108:0) after 4m9s
[20:18:22.683] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:108:0)
[20:18:22.713] Build status: STARTED
[20:18:22.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:109:0) after 7m49s
[20:26:11.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:109:0)
[20:26:11.890] Build status: STARTED
[20:26:11.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:110:0) after 8m46s
[20:34:58.055] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:110:0)
[20:34:58.085] Build status: STARTED
[20:34:58.085] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:111:0) after 8m36s
[20:43:34.106] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:111:0)
[20:43:34.139] Build status: STARTED
[20:43:34.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:112:0) after 2m23s
[20:45:57.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:112:0)
[20:45:57.253] Build status: STARTED
[20:45:57.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:113:0) after 5m49s
[20:51:46.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:113:0)
[20:51:46.313] Build status: STARTED
[20:51:46.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:114:0) after 1m1s
[20:52:47.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:114:0)
[20:52:47.387] Build status: STARTED
[20:52:47.387] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:115:0) after 9m18s
[21:02:05.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:115:0)
[21:02:05.499] Build status: STARTED
[21:02:05.499] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:116:0) after 2m34s
[21:04:39.521] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:116:0)
[21:04:39.554] Build status: STARTED
[21:04:39.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:117:0) after 9m21s
[21:14:01.027] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:117:0)
[21:14:01.065] Build status: STARTED
[21:14:01.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:118:0) after 4m27s
[21:18:28.459] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:118:0)
[21:18:28.551] Build status: STARTED
[21:18:28.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:119:0) after 9m49s
[21:28:17.657] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:119:0)
[21:28:17.690] Build status: STARTED
[21:28:17.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:120:0) after 1m33s
[21:29:50.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:120:0)
[21:29:50.815] Build status: STARTED
[21:29:50.815] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:121:0) after 6m51s
[21:36:41.841] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:121:0)
[21:36:41.889] Build status: STARTED
[21:36:41.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:122:0) after 7m26s
[21:44:08.015] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:122:0)
[21:44:08.048] Build status: STARTED
[21:44:08.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:123:0) after 4m50s
[21:48:58.227] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:123:0)
[21:48:58.258] Build status: STARTED
[21:48:58.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:124:0) after 5m57s
[21:54:55.286] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:124:0)
[21:54:55.318] Build status: STARTED
[21:54:55.318] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:125:0) after 9m13s
[22:04:08.545] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:125:0)
[22:04:08.632] Build status: STARTED
[22:04:08.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:126:0) after 5m53s
[22:10:01.717] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:126:0)
[22:10:01.752] Build status: STARTED
[22:10:01.752] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:127:0) after 7m59s
[22:18:01.070] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:127:0)
[22:18:01.112] Build status: STARTED
[22:18:01.112] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:128:0) after 4m40s
[22:22:41.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:128:0)
[22:22:41.373] Build status: STARTED
[22:22:41.373] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:129:0) after 5m43s
[22:28:24.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:129:0)
[22:28:24.438] Build status: STARTED
[22:28:24.438] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:130:0) after 4m54s
[22:33:18.506] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:130:0)
[22:33:18.540] Build status: STARTED
[22:33:18.540] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:131:0) after 4m0s
[22:37:18.827] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:131:0)
[22:37:19.097] Build status: STARTED
[22:37:19.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:132:0) after 5m46s
[22:43:05.135] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:132:0)
[22:43:05.166] Build status: STARTED
[22:43:05.166] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:133:0) after 9m57s
[22:53:02.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:133:0)
[22:53:02.559] Build status: STARTED
[22:53:02.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:134:0) after 4m36s
[22:57:38.958] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:134:0)
[22:57:39.000] Build status: STARTED
[22:57:39.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:135:0) after 7m51s
[23:05:30.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:135:0)
[23:05:30.215] Build status: STARTED
[23:05:30.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:136:0) after 1m17s
[23:06:47.898] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:136:0)
[23:06:47.927] Build status: STARTED
[23:06:47.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:137:0) after 4m35s
[23:11:23.106] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:137:0)
[23:11:23.148] Build status: STARTED
[23:11:23.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:138:0) after 2m56s
[23:14:19.174] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:138:0)
[23:14:19.223] Build status: STARTED
[23:14:19.223] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:139:0) after 3m27s
[23:17:46.245] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:139:0)
[23:17:46.272] Build status: STARTED
[23:17:46.272] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:140:0) after 7m2s
[23:24:48.504] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:140:0)
[23:24:48.546] Build status: STARTED
[23:24:48.546] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:141:0) after 7m13s
[23:32:01.927] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:141:0)
[23:32:01.974] Build status: STARTED
[23:32:01.974] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:142:0) after 2m20s
[23:34:22.262] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:142:0)
[23:34:22.302] Build status: STARTED
[23:34:22.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:143:0) after 2m12s
[23:36:34.422] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:143:0)
[23:36:34.452] Build status: STARTED
[23:36:34.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:144:0) after 6m1s
[23:42:35.573] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:144:0)
[23:42:35.603] Build status: STARTED
[23:42:35.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:145:0) after 3m13s
[23:45:48.752] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:145:0)
[23:45:48.784] Build status: STARTED
[23:45:48.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:146:0) after 2m35s
[23:48:23.765] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:146:0)
[23:48:23.804] Build status: STARTED
[23:48:23.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:147:0) after 5m0s
[23:53:23.814] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:147:0)
[23:53:23.863] Build status: STARTED
[23:53:23.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:148:0) after 2m30s
[23:55:53.851] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:148:0)
[23:55:53.905] Build status: STARTED
[23:55:53.905] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:149:0) after 9m1s
[00:04:54.929] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:149:0)
[00:04:54.972] Build status: STARTED
[00:04:54.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:150:0) after 6m36s
[00:11:31.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:150:0)
[00:11:31.102] Build status: STARTED
[00:11:31.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:151:0) after 9m58s
[00:21:29.133] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:151:0)
[00:21:29.168] Build status: STARTED
[00:21:29.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:152:0) after 3m45s
[00:25:14.419] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:152:0)
[00:25:14.455] Build status: STARTED
[00:25:14.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:153:0) after 9m14s
[00:34:28.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:153:0)
[00:34:28.513] Build status: STARTED
[00:34:28.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:154:0) after 8m5s
[00:42:33.775] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:154:0)
[00:42:33.816] Build status: STARTED
[00:42:33.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:155:0) after 6m1s
[00:48:35.104] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:155:0)
[00:48:35.134] Build status: STARTED
[00:48:35.134] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:156:0) after 5m13s
[00:53:48.174] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:156:0)
[00:53:48.282] Build status: STARTED
[00:53:48.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:157:0) after 6m20s
[01:00:08.634] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:157:0)
[01:00:08.668] Build status: STARTED
[01:00:08.668] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:158:0) after 3m0s
[01:03:08.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:158:0)
[01:03:08.800] Build status: STARTED
[01:03:08.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:159:0) after 6m57s
[01:10:05.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:159:0)
[01:10:05.853] Build status: STARTED
[01:10:05.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:160:0) after 9m0s
[01:19:06.105] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:160:0)
[01:19:06.142] Build status: STARTED
[01:19:06.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:161:0) after 1m1s
[01:20:07.519] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:161:0)
[01:20:07.554] Build status: STARTED
[01:20:07.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:162:0) after 8m58s
[01:29:05.565] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:162:0)
[01:29:05.736] Build status: STARTED
[01:29:05.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:163:0) after 4m38s
[01:33:43.824] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:163:0)
[01:33:43.857] Build status: STARTED
[01:33:43.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:164:0) after 6m9s
[01:39:52.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:164:0)
[01:39:53.026] Build status: STARTED
[01:39:53.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:165:0) after 1m14s
[01:41:07.114] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:165:0)
[01:41:07.150] Build status: STARTED
[01:41:07.150] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:166:0) after 3m29s
[01:44:36.359] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:166:0)
[01:44:36.392] Build status: STARTED
[01:44:36.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:167:0) after 4m51s
[01:49:27.797] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:167:0)
[01:49:27.832] Build status: STARTED
[01:49:27.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:168:0) after 1m59s
[01:51:26.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:168:0)
[01:51:27.002] Build status: STARTED
[01:51:27.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:169:0) after 6m8s
[01:57:35.029] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:169:0)
[01:57:35.066] Build status: STARTED
[01:57:35.066] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:170:0) after 2m27s
[02:00:02.211] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:170:0)
[02:00:02.258] Build status: STARTED
[02:00:02.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:171:0) after 3m9s
[02:03:11.381] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:171:0)
[02:03:11.420] Build status: STARTED
[02:03:11.420] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:172:0) after 2m30s
[02:05:41.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:172:0)
[02:05:41.637] Build status: STARTED
[02:05:41.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:173:0) after 2m20s
[02:08:01.760] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:173:0)
[02:08:01.810] Build status: STARTED
[02:08:01.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:174:0) after 4m49s
[02:12:50.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:174:0)
[02:12:50.868] Build status: STARTED
[02:12:50.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:175:0) after 7m15s
[02:20:05.935] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:175:0)
[02:20:05.964] Build status: STARTED
[02:20:05.964] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:176:0) after 6m24s
[02:26:30.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:176:0)
[02:26:30.041] Build status: STARTED
[02:26:30.041] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:177:0) after 6m0s
[02:32:30.106] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:177:0)
[02:32:30.136] Build status: STARTED
[02:32:30.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:178:0) after 6m43s
[02:39:13.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:178:0)
[02:39:13.293] Build status: STARTED
[02:39:13.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:179:0) after 9m1s
[02:48:14.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:179:0)
[02:48:14.433] Build status: STARTED
[02:48:14.433] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:180:0) after 8m20s
[02:56:34.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:180:0)
[02:56:34.508] Build status: STARTED
[02:56:34.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:181:0) after 7m17s
[03:03:51.683] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:181:0)
[03:03:51.735] Build status: STARTED
[03:03:51.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:182:0) after 1m6s
[03:04:58.033] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:182:0)
[03:04:58.061] Build status: STARTED
[03:04:58.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:183:0) after 9m18s
[03:14:16.088] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:183:0)
[03:14:16.125] Build status: STARTED
[03:14:16.125] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:184:0) after 3m54s
[03:18:10.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:184:0)
[03:18:10.190] Build status: STARTED
[03:18:10.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:185:0) after 9m23s
[03:27:33.439] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:185:0)
[03:27:33.466] Build status: STARTED
[03:27:33.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:186:0) after 3m53s
[03:31:26.524] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:186:0)
[03:31:26.552] Build status: STARTED
[03:31:26.552] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:187:0) after 4m19s
[03:35:45.820] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:187:0)
[03:35:45.853] Build status: STARTED
[03:35:45.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:188:0) after 5m19s
[03:41:04.876] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:188:0)
[03:41:04.909] Build status: STARTED
[03:41:04.909] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:189:0) after 2m42s
[03:43:46.944] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:189:0)
[03:43:46.979] Build status: STARTED
[03:43:46.979] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:190:0) after 8m36s
[03:52:23.363] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:190:0)
[03:52:23.391] Build status: STARTED
[03:52:23.391] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:191:0) after 4m19s
[03:56:42.414] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:191:0)
[03:56:42.442] Build status: STARTED
[03:56:42.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:192:0) after 5m16s
[04:01:58.613] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:192:0)
[04:01:58.662] Build status: STARTED
[04:01:58.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:193:0) after 3m26s
[04:05:24.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:193:0)
[04:05:24.890] Build status: STARTED
[04:05:24.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:194:0) after 9m21s
[04:14:45.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:194:0)
[04:14:45.961] Build status: STARTED
[04:14:45.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:195:0) after 4m19s
[04:19:04.953] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:195:0)
[04:19:04.987] Build status: STARTED
[04:19:04.987] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:196:0) after 1m20s
[04:20:25.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:196:0)
[04:20:25.065] Build status: STARTED
[04:20:25.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:197:0) after 9m10s
[04:29:35.208] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:197:0)
[04:29:35.297] Build status: STARTED
[04:29:35.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:198:0) after 9m51s
[04:39:26.284] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:198:0)
[04:39:26.313] Build status: STARTED
[04:39:26.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:199:0) after 2m40s
[04:42:06.336] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:199:0)
[04:42:06.369] Build status: STARTED
[04:42:06.369] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:200:0) after 2m19s
[04:44:25.636] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:200:0)
[04:44:25.797] Build status: STARTED
[04:44:25.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:201:0) after 7m6s
[04:51:31.979] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:201:0)
[04:51:32.021] Build status: STARTED
[04:51:32.021] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:202:0) after 8m18s
[04:59:50.184] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:202:0)
[04:59:50.211] Build status: STARTED
[04:59:50.211] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:203:0) after 2m28s
[05:02:18.237] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:203:0)
[05:02:18.277] Build status: STARTED
[05:02:18.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:204:0) after 3m29s
[05:05:47.811] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:204:0)
[05:05:47.839] Build status: STARTED
[05:05:47.839] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:205:0) after 3m18s
[05:09:05.899] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:205:0)
[05:09:05.926] Build status: STARTED
[05:09:05.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:206:0) after 2m3s
[05:11:09.053] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:206:0)
[05:11:09.093] Build status: STARTED
[05:11:09.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:207:0) after 5m14s
[05:16:23.117] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:207:0)
[05:16:23.148] Build status: STARTED
[05:16:23.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:208:0) after 8m17s
[05:24:40.170] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:208:0)
[05:24:40.276] Build status: STARTED
[05:24:40.276] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:209:0) after 6m26s
[05:31:06.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:209:0)
[05:31:06.379] Build status: STARTED
[05:31:06.379] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:210:0) after 2m23s
[05:33:29.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:210:0)
[05:33:29.475] Build status: STARTED
[05:33:29.475] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:211:0) after 6m30s
[05:39:59.510] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:211:0)
[05:39:59.580] Build status: STARTED
[05:39:59.580] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:212:0) after 3m26s
[05:43:25.682] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:212:0)
[05:43:25.739] Build status: STARTED
[05:43:25.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:213:0) after 4m20s
[05:47:46.350] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:213:0)
[05:47:46.392] Build status: STARTED
[05:47:46.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:214:0) after 3m43s
[05:51:29.489] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:214:0)
[05:51:29.554] Build status: STARTED
[05:51:29.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:215:0) after 1m31s
[05:53:00.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:215:0)
[05:53:00.786] Build status: STARTED
[05:53:00.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:216:0) after 5m53s
[05:58:53.831] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:216:0)
[05:58:53.868] Build status: STARTED
[05:58:53.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:217:0) after 8m13s
[06:07:07.299] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:217:0)
[06:07:07.327] Build status: STARTED
[06:07:07.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:218:0) after 2m5s
[06:09:12.739] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:218:0)
[06:09:12.768] Build status: STARTED
[06:09:12.768] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:219:0) after 9m53s
[06:19:06.012] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:219:0)
[06:19:06.081] Build status: STARTED
[06:19:06.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:220:0) after 4m30s
[06:23:36.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:220:0)
[06:23:36.338] Build status: STARTED
[06:23:36.338] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:221:0) after 5m2s
[06:28:38.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:221:0)
[06:28:38.527] Build status: STARTED
[06:28:38.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:222:0) after 8m28s
[06:37:06.644] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:222:0)
[06:37:06.681] Build status: STARTED
[06:37:06.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:223:0) after 2m22s
[06:39:29.012] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:223:0)
[06:39:29.047] Build status: STARTED
[06:39:29.047] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:224:0) after 2m32s
[06:42:01.371] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:224:0)
[06:42:01.419] Build status: STARTED
[06:42:01.419] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:225:0) after 4m7s
[06:46:08.441] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:225:0)
[06:46:08.491] Build status: STARTED
[06:46:08.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:226:0) after 3m39s
[06:49:47.482] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:226:0)
[06:49:47.536] Build status: STARTED
[06:49:47.536] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:227:0) after 5m24s
[06:55:11.542] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:227:0)
[06:55:11.584] Build status: STARTED
[06:55:11.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:228:0) after 6m4s
[07:01:15.728] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:228:0)
[07:01:15.756] Build status: STARTED
[07:01:15.756] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:229:0) after 4m48s
[07:06:03.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:229:0)
[07:06:03.816] Build status: STARTED
[07:06:03.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:230:0) after 4m32s
[07:10:36.077] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:230:0)
[07:10:36.120] Build status: STARTED
[07:10:36.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:231:0) after 2m5s
[07:12:41.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:231:0)
[07:12:41.259] Build status: STARTED
[07:12:41.259] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:232:0) after 4m27s
[07:17:08.281] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:232:0)
[07:17:08.306] Build status: STARTED
[07:17:08.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:233:0) after 7m58s
[07:25:06.360] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:233:0)
[07:25:06.415] Build status: STARTED
[07:25:06.415] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:234:0) after 6m55s
[07:32:01.450] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:234:0)
[07:32:01.485] Build status: STARTED
[07:32:01.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:235:0) after 3m33s
[07:35:34.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:235:0)
[07:35:34.736] Build status: STARTED
[07:35:34.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:236:0) after 2m2s
[07:37:36.773] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:236:0)
[07:37:36.811] Build status: STARTED
[07:37:36.811] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8997106471519392416:237:0) after 6m8s
[07:43:30.886] Received PubSub notification, asking Buildbucket for the build status
[07:43:30.913] Build:
{
"id": "8831676409570988849",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 525,
"createdBy": "project:r8",
"createTime": "2021-11-02T11:54:19.589806420Z",
"startTime": "2021-11-02T19:43:10.495286Z",
"endTime": "2021-11-03T07:43:30.104222Z",
"updateTime": "2021-11-03T07:43:30.483493Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "fdf08281f38e89d338032bc747a48d2393f8de7d",
"ref": "refs/heads/3.1"
}
}
}
[07:43:30.913] Invocation finished in 19h49m12.565708601s with status FAILED