[07:51:22.214] New invocation is queued and will start shortly
[07:51:23.351] Starting the invocation (attempt 1)
[07:51:23.385] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/db7123358d03d43da321fcff3c590bb9fadbbe29"
[07:51:23.385] Popped gitiles commit info from properties and tags
[07:51:23.385] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:51:23.385] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:51:23.386] Buildbucket request:
{
"requestId": "8996940561785958320",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/3.2",
"repo": "https://r8.googlesource.com/r8",
"revision": "db7123358d03d43da321fcff3c590bb9fadbbe29"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/3.2@db7123358d03d43da321fcff3c590bb9fadbbe29",
"title": "db7123358d03d43da321fcff3c590bb9fadbbe29",
"url": "https://r8.googlesource.com/r8/+/db7123358d03d43da321fcff3c590bb9fadbbe29"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "db7123358d03d43da321fcff3c590bb9fadbbe29",
"ref": "refs/heads/3.2"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8996940561785958320"
},
{
"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"
}
}
[07:51:23.928] Scheduled build:
{
"id": "8831510499833803649",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 527,
"createdBy": "project:r8",
"createTime": "2021-11-04T07:51:23.444760254Z",
"updateTime": "2021-11-04T07:51:23.444760254Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "db7123358d03d43da321fcff3c590bb9fadbbe29",
"ref": "refs/heads/3.2"
}
}
}
[07:51:23.928] Task URL: https://cr-buildbucket.appspot.com/build/8831510499833803649
[07:51:23.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:2:0) after 6m1s
[07:57:24.948] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:2:0)
[07:57:24.998] Build status: SCHEDULED
[07:57:24.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:3:0) after 1m18s
[07:58:43.058] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:3:0)
[07:58:43.100] Build status: SCHEDULED
[07:58:43.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:4:0) after 1m50s
[08:00:33.300] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:4:0)
[08:00:33.333] Build status: SCHEDULED
[08:00:33.333] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:5:0) after 2m39s
[08:03:12.476] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:5:0)
[08:03:12.557] Build status: SCHEDULED
[08:03:12.557] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:6:0) after 3m54s
[08:07:06.789] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:6:0)
[08:07:06.824] Build status: SCHEDULED
[08:07:06.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:7:0) after 6m25s
[08:13:31.993] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:7:0)
[08:13:32.028] Build status: SCHEDULED
[08:13:32.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:8:0) after 7m22s
[08:20:54.108] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:8:0)
[08:20:54.178] Build status: SCHEDULED
[08:20:54.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:9:0) after 8m59s
[08:29:53.194] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:9:0)
[08:29:53.245] Build status: SCHEDULED
[08:29:53.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:10:0) after 4m52s
[08:34:45.265] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:10:0)
[08:34:45.319] Build status: SCHEDULED
[08:34:45.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:11:0) after 3m40s
[08:38:25.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:11:0)
[08:38:25.378] Build status: SCHEDULED
[08:38:25.378] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:12:0) after 8m38s
[08:47:03.624] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:12:0)
[08:47:03.653] Build status: SCHEDULED
[08:47:03.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:13:0) after 6m26s
[08:53:29.669] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:13:0)
[08:53:29.708] Build status: SCHEDULED
[08:53:29.708] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:14:0) after 7m26s
[09:00:55.793] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:14:0)
[09:00:55.821] Build status: SCHEDULED
[09:00:55.821] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:15:0) after 3m9s
[09:04:04.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:15:0)
[09:04:04.874] Build status: SCHEDULED
[09:04:04.874] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:16:0) after 7m33s
[09:11:37.917] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:16:0)
[09:11:37.942] Build status: SCHEDULED
[09:11:37.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:17:0) after 8m23s
[09:20:01.006] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:17:0)
[09:20:01.044] Build status: SCHEDULED
[09:20:01.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:18:0) after 1m46s
[09:21:47.056] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:18:0)
[09:21:47.083] Build status: SCHEDULED
[09:21:47.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:19:0) after 7m48s
[09:29:35.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:19:0)
[09:29:35.171] Build status: SCHEDULED
[09:29:35.171] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:20:0) after 8m43s
[09:38:18.188] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:20:0)
[09:38:18.220] Build status: SCHEDULED
[09:38:18.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:21:0) after 3m58s
[09:42:16.197] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:21:0)
[09:42:16.271] Build status: SCHEDULED
[09:42:16.271] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:22:0) after 5m53s
[09:48:09.385] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:22:0)
[09:48:09.431] Build status: SCHEDULED
[09:48:09.431] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:23:0) after 7m25s
[09:55:34.487] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:23:0)
[09:55:34.547] Build status: SCHEDULED
[09:55:34.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:24:0) after 4m41s
[10:00:15.610] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:24:0)
[10:00:15.649] Build status: SCHEDULED
[10:00:15.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:25:0) after 3m2s
[10:03:17.668] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:25:0)
[10:03:17.694] Build status: SCHEDULED
[10:03:17.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:26:0) after 9m51s
[10:13:08.807] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:26:0)
[10:13:08.837] Build status: SCHEDULED
[10:13:08.837] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:27:0) after 7m48s
[10:20:56.901] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:27:0)
[10:20:56.982] Build status: SCHEDULED
[10:20:56.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:28:0) after 6m58s
[10:27:55.088] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:28:0)
[10:27:55.122] Build status: SCHEDULED
[10:27:55.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:29:0) after 6m13s
[10:34:08.224] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:29:0)
[10:34:08.254] Build status: SCHEDULED
[10:34:08.254] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:30:0) after 6m37s
[10:40:45.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:30:0)
[10:40:45.300] Build status: SCHEDULED
[10:40:45.300] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:31:0) after 6m1s
[10:46:46.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:31:0)
[10:46:46.501] Build status: SCHEDULED
[10:46:46.501] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:32:0) after 4m37s
[10:51:23.772] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:32:0)
[10:51:23.804] Build status: SCHEDULED
[10:51:23.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:33:0) after 8m47s
[11:00:10.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:33:0)
[11:00:10.907] Build status: SCHEDULED
[11:00:10.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:34:0) after 4m22s
[11:04:32.927] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:34:0)
[11:04:32.971] Build status: SCHEDULED
[11:04:32.971] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:35:0) after 7m16s
[11:11:49.004] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:35:0)
[11:11:49.045] Build status: SCHEDULED
[11:11:49.045] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:36:0) after 2m44s
[11:14:33.188] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:36:0)
[11:14:33.227] Build status: SCHEDULED
[11:14:33.227] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:37:0) after 2m30s
[11:17:03.350] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:37:0)
[11:17:03.392] Build status: SCHEDULED
[11:17:03.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:38:0) after 1m12s
[11:18:15.610] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:38:0)
[11:18:15.695] Build status: SCHEDULED
[11:18:15.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:39:0) after 4m17s
[11:22:32.979] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:39:0)
[11:22:33.036] Build status: SCHEDULED
[11:22:33.036] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:40:0) after 5m32s
[11:28:05.056] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:40:0)
[11:28:05.095] Build status: SCHEDULED
[11:28:05.095] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:41:0) after 1m32s
[11:29:37.119] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:41:0)
[11:29:37.149] Build status: SCHEDULED
[11:29:37.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:42:0) after 2m21s
[11:31:58.169] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:42:0)
[11:31:58.206] Build status: SCHEDULED
[11:31:58.206] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:43:0) after 6m8s
[11:38:06.267] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:43:0)
[11:38:06.296] Build status: SCHEDULED
[11:38:06.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:44:0) after 2m32s
[11:40:38.332] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:44:0)
[11:40:38.365] Build status: SCHEDULED
[11:40:38.365] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:45:0) after 9m46s
[11:50:24.396] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:45:0)
[11:50:24.425] Build status: SCHEDULED
[11:50:24.425] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:46:0) after 7m8s
[11:57:32.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:46:0)
[11:57:32.475] Build status: SCHEDULED
[11:57:32.475] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:47:0) after 3m23s
[12:00:55.534] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:47:0)
[12:00:55.572] Build status: SCHEDULED
[12:00:55.572] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:48:0) after 5m29s
[12:06:24.601] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:48:0)
[12:06:24.636] Build status: SCHEDULED
[12:06:24.636] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:49:0) after 9m24s
[12:15:48.740] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:49:0)
[12:15:48.772] Build status: SCHEDULED
[12:15:48.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:50:0) after 4m53s
[12:20:41.793] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:50:0)
[12:20:41.817] Build status: SCHEDULED
[12:20:41.817] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:51:0) after 3m19s
[12:24:01.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:51:0)
[12:24:01.065] Build status: SCHEDULED
[12:24:01.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:52:0) after 2m37s
[12:26:38.087] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:52:0)
[12:26:38.119] Build status: SCHEDULED
[12:26:38.119] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:53:0) after 5m18s
[12:31:56.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:53:0)
[12:31:56.196] Build status: SCHEDULED
[12:31:56.196] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:54:0) after 6m26s
[12:38:22.236] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:54:0)
[12:38:22.269] Build status: SCHEDULED
[12:38:22.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:55:0) after 3m40s
[12:42:02.312] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:55:0)
[12:42:02.358] Build status: SCHEDULED
[12:42:02.358] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:56:0) after 8m12s
[12:50:14.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:56:0)
[12:50:14.434] Build status: SCHEDULED
[12:50:14.434] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:57:0) after 6m42s
[12:56:56.470] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:57:0)
[12:56:56.505] Build status: SCHEDULED
[12:56:56.505] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:58:0) after 1m52s
[12:58:48.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:58:0)
[12:58:48.600] Build status: SCHEDULED
[12:58:48.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:59:0) after 1m8s
[12:59:56.628] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:59:0)
[12:59:56.661] Build status: SCHEDULED
[12:59:56.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:60:0) after 7m46s
[13:07:42.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:60:0)
[13:07:42.829] Build status: SCHEDULED
[13:07:42.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:61:0) after 1m28s
[13:09:10.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:61:0)
[13:09:10.877] Build status: SCHEDULED
[13:09:10.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:62:0) after 6m19s
[13:15:30.019] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:62:0)
[13:15:30.054] Build status: SCHEDULED
[13:15:30.054] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:63:0) after 9m29s
[13:24:59.149] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:63:0)
[13:24:59.177] Build status: SCHEDULED
[13:24:59.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:64:0) after 9m35s
[13:34:34.686] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:64:0)
[13:34:34.716] Build status: SCHEDULED
[13:34:34.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:65:0) after 5m45s
[13:40:19.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:65:0)
[13:40:19.855] Build status: SCHEDULED
[13:40:19.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:66:0) after 3m15s
[13:43:34.954] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:66:0)
[13:43:34.988] Build status: SCHEDULED
[13:43:34.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:67:0) after 7m10s
[13:50:45.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:67:0)
[13:50:45.068] Build status: SCHEDULED
[13:50:45.068] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:68:0) after 5m43s
[13:56:28.118] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:68:0)
[13:56:28.145] Build status: SCHEDULED
[13:56:28.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:69:0) after 6m35s
[14:03:03.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:69:0)
[14:03:03.228] Build status: SCHEDULED
[14:03:03.228] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:70:0) after 1m14s
[14:04:17.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:70:0)
[14:04:17.323] Build status: SCHEDULED
[14:04:17.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:71:0) after 3m27s
[14:07:44.612] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:71:0)
[14:07:44.641] Build status: SCHEDULED
[14:07:44.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:72:0) after 5m36s
[14:13:20.668] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:72:0)
[14:13:20.694] Build status: SCHEDULED
[14:13:20.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:73:0) after 7m54s
[14:21:14.877] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:73:0)
[14:21:14.907] Build status: SCHEDULED
[14:21:14.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:74:0) after 5m43s
[14:26:58.034] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:74:0)
[14:26:58.087] Build status: SCHEDULED
[14:26:58.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:75:0) after 1m35s
[14:28:33.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:75:0)
[14:28:33.176] Build status: SCHEDULED
[14:28:33.176] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:76:0) after 4m36s
[14:33:09.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:76:0)
[14:33:09.244] Build status: SCHEDULED
[14:33:09.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:77:0) after 9m29s
[14:42:38.272] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:77:0)
[14:42:38.305] Build status: SCHEDULED
[14:42:38.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:78:0) after 7m48s
[14:50:26.290] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:78:0)
[14:50:26.321] Build status: SCHEDULED
[14:50:26.321] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:79:0) after 7m44s
[14:58:10.533] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:79:0)
[14:58:10.621] Build status: SCHEDULED
[14:58:10.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:80:0) after 9m49s
[15:07:59.814] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:80:0)
[15:07:59.843] Build status: SCHEDULED
[15:07:59.843] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:81:0) after 6m53s
[15:14:52.890] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:81:0)
[15:14:52.918] Build status: SCHEDULED
[15:14:52.918] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:82:0) after 5m33s
[15:20:26.052] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:82:0)
[15:20:26.093] Build status: SCHEDULED
[15:20:26.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:83:0) after 9m18s
[15:29:44.214] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:83:0)
[15:29:44.243] Build status: SCHEDULED
[15:29:44.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:84:0) after 7m15s
[15:36:59.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:84:0)
[15:36:59.469] Build status: SCHEDULED
[15:36:59.469] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:85:0) after 7m14s
[15:44:13.492] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:85:0)
[15:44:13.547] Build status: SCHEDULED
[15:44:13.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:86:0) after 4m13s
[15:48:26.573] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:86:0)
[15:48:26.608] Build status: SCHEDULED
[15:48:26.608] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:87:0) after 8m22s
[15:56:48.637] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:87:0)
[15:56:48.665] Build status: SCHEDULED
[15:56:48.665] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:88:0) after 7m34s
[16:04:22.962] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:88:0)
[16:04:23.004] Build status: SCHEDULED
[16:04:23.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:89:0) after 9m51s
[16:14:14.079] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:89:0)
[16:14:14.105] Build status: SCHEDULED
[16:14:14.105] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:90:0) after 1m34s
[16:15:48.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:90:0)
[16:15:48.559] Build status: SCHEDULED
[16:15:48.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:91:0) after 8m41s
[16:24:29.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:91:0)
[16:24:29.793] Build status: SCHEDULED
[16:24:29.793] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:92:0) after 3m14s
[16:27:44.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:92:0)
[16:27:44.208] Build status: SCHEDULED
[16:27:44.208] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:93:0) after 2m59s
[16:30:43.328] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:93:0)
[16:30:43.476] Build status: SCHEDULED
[16:30:43.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:94:0) after 7m53s
[16:38:36.697] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:94:0)
[16:38:36.736] Build status: SCHEDULED
[16:38:36.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:95:0) after 2m49s
[16:41:25.891] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:95:0)
[16:41:25.921] Build status: SCHEDULED
[16:41:25.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:96:0) after 7m15s
[16:48:41.084] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:96:0)
[16:48:41.123] Build status: SCHEDULED
[16:48:41.123] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:97:0) after 2m33s
[16:51:14.180] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:97:0)
[16:51:14.229] Build status: SCHEDULED
[16:51:14.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:98:0) after 3m49s
[16:55:03.498] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:98:0)
[16:55:03.586] Build status: SCHEDULED
[16:55:03.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:99:0) after 1m59s
[16:57:03.049] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:99:0)
[16:57:03.088] Build status: SCHEDULED
[16:57:03.088] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:100:0) after 3m49s
[17:00:52.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:100:0)
[17:00:52.372] Build status: SCHEDULED
[17:00:52.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:101:0) after 7m51s
[17:08:43.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:101:0)
[17:08:43.439] Build status: SCHEDULED
[17:08:43.439] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:102:0) after 5m25s
[17:14:08.625] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:102:0)
[17:14:08.653] Build status: SCHEDULED
[17:14:08.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:103:0) after 8m41s
[17:22:49.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:103:0)
[17:22:49.719] Build status: SCHEDULED
[17:22:49.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:104:0) after 6m42s
[17:29:31.884] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:104:0)
[17:29:31.910] Build status: SCHEDULED
[17:29:31.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:105:0) after 4m39s
[17:34:11.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:105:0)
[17:34:11.067] Build status: SCHEDULED
[17:34:11.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:106:0) after 4m28s
[17:38:39.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:106:0)
[17:38:39.325] Build status: SCHEDULED
[17:38:39.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:107:0) after 7m36s
[17:46:15.583] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:107:0)
[17:46:15.619] Build status: SCHEDULED
[17:46:15.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:108:0) after 6m54s
[17:53:09.648] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:108:0)
[17:53:09.684] Build status: SCHEDULED
[17:53:09.684] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:109:0) after 3m28s
[17:56:37.822] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:109:0)
[17:56:37.863] Build status: SCHEDULED
[17:56:37.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:110:0) after 6m41s
[18:03:18.985] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:110:0)
[18:03:19.018] Build status: SCHEDULED
[18:03:19.018] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:111:0) after 8m47s
[18:12:06.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:111:0)
[18:12:06.215] Build status: SCHEDULED
[18:12:06.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:112:0) after 4m18s
[18:16:24.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:112:0)
[18:16:24.298] Build status: SCHEDULED
[18:16:24.298] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:113:0) after 7m42s
[18:24:06.369] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:113:0)
[18:24:06.395] Build status: SCHEDULED
[18:24:06.395] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:114:0) after 4m18s
[18:28:24.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:114:0)
[18:28:24.504] Build status: SCHEDULED
[18:28:24.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:115:0) after 6m15s
[18:34:39.560] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:115:0)
[18:34:39.590] Build status: SCHEDULED
[18:34:39.590] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:116:0) after 2m25s
[18:37:04.624] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:116:0)
[18:37:04.654] Build status: SCHEDULED
[18:37:04.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:117:0) after 7m30s
[18:44:34.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:117:0)
[18:44:34.746] Build status: SCHEDULED
[18:44:34.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:118:0) after 1m37s
[18:46:11.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:118:0)
[18:46:11.810] Build status: SCHEDULED
[18:46:11.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:119:0) after 8m47s
[18:54:58.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:119:0)
[18:54:58.862] Build status: SCHEDULED
[18:54:58.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:120:0) after 2m32s
[18:57:30.891] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:120:0)
[18:57:30.980] Build status: SCHEDULED
[18:57:30.980] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:121:0) after 6m18s
[19:03:49.046] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:121:0)
[19:03:49.076] Build status: SCHEDULED
[19:03:49.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:122:0) after 7m51s
[19:11:40.104] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:122:0)
[19:11:40.135] Build status: SCHEDULED
[19:11:40.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:123:0) after 9m24s
[19:21:04.208] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:123:0)
[19:21:04.238] Build status: SCHEDULED
[19:21:04.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:124:0) after 8m55s
[19:29:59.263] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:124:0)
[19:29:59.292] Build status: SCHEDULED
[19:29:59.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:125:0) after 7m40s
[19:37:39.314] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:125:0)
[19:37:39.367] Build status: SCHEDULED
[19:37:39.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:126:0) after 7m59s
[19:45:38.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:126:0)
[19:45:38.418] Build status: SCHEDULED
[19:45:38.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:127:0) after 8m14s
[19:53:52.482] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:127:0)
[19:53:52.517] Build status: SCHEDULED
[19:53:52.517] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:128:0) after 6m19s
[19:58:38.770] Received PubSub notification, asking Buildbucket for the build status
[19:58:38.798] Build status: STARTED
[20:00:11.562] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:128:0)
[20:00:11.603] Build status: STARTED
[20:00:11.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:130:0) after 7m13s
[20:07:24.643] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:130:0)
[20:07:24.673] Build status: STARTED
[20:07:24.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:131:0) after 3m12s
[20:10:36.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:131:0)
[20:10:36.809] Build status: STARTED
[20:10:36.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:132:0) after 8m48s
[20:19:24.887] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:132:0)
[20:19:24.920] Build status: STARTED
[20:19:24.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:133:0) after 7m41s
[20:27:05.970] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:133:0)
[20:27:05.999] Build status: STARTED
[20:27:05.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:134:0) after 3m29s
[20:30:35.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:134:0)
[20:30:35.041] Build status: STARTED
[20:30:35.041] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:135:0) after 2m33s
[20:33:08.076] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:135:0)
[20:33:08.129] Build status: STARTED
[20:33:08.129] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:136:0) after 7m19s
[20:40:27.215] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:136:0)
[20:40:27.252] Build status: STARTED
[20:40:27.252] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:137:0) after 2m13s
[20:42:40.273] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:137:0)
[20:42:40.468] Build status: STARTED
[20:42:40.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:138:0) after 9m15s
[20:51:55.490] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:138:0)
[20:51:55.524] Build status: STARTED
[20:51:55.524] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:139:0) after 6m39s
[20:58:34.637] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:139:0)
[20:58:34.670] Build status: STARTED
[20:58:34.670] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:140:0) after 7m41s
[21:06:15.758] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:140:0)
[21:06:15.805] Build status: STARTED
[21:06:15.805] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:141:0) after 4m16s
[21:10:31.827] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:141:0)
[21:10:31.863] Build status: STARTED
[21:10:31.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:142:0) after 2m50s
[21:13:21.887] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:142:0)
[21:13:21.913] Build status: STARTED
[21:13:21.913] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:143:0) after 7m46s
[21:21:07.938] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:143:0)
[21:21:07.971] Build status: STARTED
[21:21:07.971] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:144:0) after 1m11s
[21:22:18.992] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:144:0)
[21:22:19.032] Build status: STARTED
[21:22:19.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:145:0) after 8m55s
[21:31:14.685] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:145:0)
[21:31:14.716] Build status: STARTED
[21:31:14.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:146:0) after 2m54s
[21:34:08.767] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:146:0)
[21:34:08.800] Build status: STARTED
[21:34:08.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:147:0) after 1m11s
[21:35:19.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:147:0)
[21:35:19.998] Build status: STARTED
[21:35:19.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:148:0) after 4m4s
[21:39:24.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:148:0)
[21:39:24.194] Build status: STARTED
[21:39:24.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:149:0) after 9m53s
[21:49:17.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:149:0)
[21:49:17.258] Build status: STARTED
[21:49:17.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:150:0) after 1m30s
[21:50:47.451] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:150:0)
[21:50:47.588] Build status: STARTED
[21:50:47.588] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:151:0) after 3m47s
[21:54:34.744] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:151:0)
[21:54:34.774] Build status: STARTED
[21:54:34.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:152:0) after 5m11s
[21:59:46.261] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:152:0)
[21:59:46.292] Build status: STARTED
[21:59:46.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:153:0) after 8m6s
[22:07:52.589] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:153:0)
[22:07:52.618] Build status: STARTED
[22:07:52.618] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:154:0) after 1m37s
[22:09:29.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:154:0)
[22:09:29.693] Build status: STARTED
[22:09:29.693] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:155:0) after 4m56s
[22:14:25.843] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:155:0)
[22:14:25.871] Build status: STARTED
[22:14:25.871] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:156:0) after 4m35s
[22:19:00.941] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:156:0)
[22:19:00.976] Build status: STARTED
[22:19:00.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:157:0) after 5m3s
[22:24:04.173] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:157:0)
[22:24:04.257] Build status: STARTED
[22:24:04.257] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:158:0) after 5m42s
[22:29:46.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:158:0)
[22:29:46.415] Build status: STARTED
[22:29:46.415] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:159:0) after 7m43s
[22:37:29.448] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:159:0)
[22:37:29.491] Build status: STARTED
[22:37:29.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:160:0) after 8m25s
[22:45:54.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:160:0)
[22:45:54.644] Build status: STARTED
[22:45:54.644] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:161:0) after 3m45s
[22:49:39.732] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:161:0)
[22:49:39.769] Build status: STARTED
[22:49:39.769] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:162:0) after 2m40s
[22:52:19.791] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:162:0)
[22:52:19.818] Build status: STARTED
[22:52:19.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:163:0) after 3m37s
[22:55:56.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:163:0)
[22:55:57.021] Build status: STARTED
[22:55:57.021] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:164:0) after 3m4s
[22:59:01.172] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:164:0)
[22:59:01.253] Build status: STARTED
[22:59:01.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:165:0) after 7m32s
[23:06:33.291] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:165:0)
[23:06:33.325] Build status: STARTED
[23:06:33.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:166:0) after 8m47s
[23:15:20.775] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:166:0)
[23:15:20.822] Build status: STARTED
[23:15:20.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:167:0) after 4m48s
[23:20:08.859] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:167:0)
[23:20:08.894] Build status: STARTED
[23:20:08.894] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:168:0) after 1m21s
[23:21:29.911] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:168:0)
[23:21:29.942] Build status: STARTED
[23:21:29.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:169:0) after 6m55s
[23:28:25.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:169:0)
[23:28:25.096] Build status: STARTED
[23:28:25.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:170:0) after 7m43s
[23:36:08.120] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:170:0)
[23:36:08.153] Build status: STARTED
[23:36:08.153] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:171:0) after 5m37s
[23:41:45.189] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:171:0)
[23:41:45.224] Build status: STARTED
[23:41:45.224] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:172:0) after 1m0s
[23:42:45.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:172:0)
[23:42:45.384] Build status: STARTED
[23:42:45.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:173:0) after 5m26s
[23:48:11.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:173:0)
[23:48:11.565] Build status: STARTED
[23:48:11.565] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:174:0) after 9m54s
[23:58:05.588] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:174:0)
[23:58:05.620] Build status: STARTED
[23:58:05.620] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:175:0) after 2m49s
[00:00:54.685] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:175:0)
[00:00:54.723] Build status: STARTED
[00:00:54.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:176:0) after 3m32s
[00:04:26.746] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:176:0)
[00:04:26.780] Build status: STARTED
[00:04:26.780] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:177:0) after 7m3s
[00:11:29.968] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:177:0)
[00:11:30.061] Build status: STARTED
[00:11:30.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:178:0) after 7m42s
[00:19:12.082] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:178:0)
[00:19:12.111] Build status: STARTED
[00:19:12.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:179:0) after 5m18s
[00:24:30.167] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:179:0)
[00:24:30.236] Build status: STARTED
[00:24:30.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:180:0) after 1m26s
[00:25:56.431] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:180:0)
[00:25:56.459] Build status: STARTED
[00:25:56.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:181:0) after 2m20s
[00:28:16.439] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:181:0)
[00:28:16.490] Build status: STARTED
[00:28:16.490] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:182:0) after 6m40s
[00:34:56.517] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:182:0)
[00:34:56.548] Build status: STARTED
[00:34:56.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:183:0) after 5m47s
[00:40:43.827] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:183:0)
[00:40:43.861] Build status: STARTED
[00:40:43.861] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:184:0) after 1m27s
[00:42:10.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:184:0)
[00:42:10.944] Build status: STARTED
[00:42:10.944] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:185:0) after 4m54s
[00:47:05.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:185:0)
[00:47:05.120] Build status: STARTED
[00:47:05.120] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:186:0) after 6m21s
[00:53:26.222] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:186:0)
[00:53:26.256] Build status: STARTED
[00:53:26.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:187:0) after 8m47s
[01:02:13.403] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:187:0)
[01:02:13.441] Build status: STARTED
[01:02:13.441] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:188:0) after 7m5s
[01:09:18.468] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:188:0)
[01:09:18.504] Build status: STARTED
[01:09:18.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:189:0) after 7m9s
[01:16:27.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:189:0)
[01:16:27.588] Build status: STARTED
[01:16:27.588] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:190:0) after 7m11s
[01:23:38.617] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:190:0)
[01:23:38.649] Build status: STARTED
[01:23:38.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:191:0) after 5m57s
[01:29:35.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:191:0)
[01:29:35.835] Build status: STARTED
[01:29:35.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:192:0) after 8m15s
[01:37:50.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:192:0)
[01:37:51.015] Build status: STARTED
[01:37:51.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:193:0) after 1m3s
[01:38:54.116] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:193:0)
[01:38:54.160] Build status: STARTED
[01:38:54.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:194:0) after 3m59s
[01:42:53.190] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:194:0)
[01:42:53.223] Build status: STARTED
[01:42:53.223] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:195:0) after 7m1s
[01:49:54.475] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:195:0)
[01:49:54.536] Build status: STARTED
[01:49:54.536] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:196:0) after 3m36s
[01:53:30.801] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:196:0)
[01:53:30.973] Build status: STARTED
[01:53:30.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:197:0) after 6m20s
[01:59:51.041] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:197:0)
[01:59:51.077] Build status: STARTED
[01:59:51.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:198:0) after 9m43s
[02:09:34.296] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:198:0)
[02:09:34.327] Build status: STARTED
[02:09:34.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:199:0) after 8m0s
[02:17:34.454] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:199:0)
[02:17:34.493] Build status: STARTED
[02:17:34.493] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:200:0) after 9m29s
[02:27:03.579] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:200:0)
[02:27:03.609] Build status: STARTED
[02:27:03.609] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:201:0) after 5m27s
[02:32:30.738] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:201:0)
[02:32:30.774] Build status: STARTED
[02:32:30.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:202:0) after 7m51s
[02:40:22.002] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:202:0)
[02:40:22.034] Build status: STARTED
[02:40:22.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:203:0) after 4m19s
[02:44:41.264] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:203:0)
[02:44:41.297] Build status: STARTED
[02:44:41.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:204:0) after 6m27s
[02:51:08.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:204:0)
[02:51:08.489] Build status: STARTED
[02:51:08.489] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:205:0) after 1m14s
[02:52:22.513] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:205:0)
[02:52:22.543] Build status: STARTED
[02:52:22.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:206:0) after 4m55s
[02:57:17.647] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:206:0)
[02:57:17.694] Build status: STARTED
[02:57:17.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:207:0) after 8m43s
[03:06:00.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:207:0)
[03:06:00.809] Build status: STARTED
[03:06:00.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:208:0) after 5m49s
[03:11:49.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:208:0)
[03:11:49.883] Build status: STARTED
[03:11:49.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:209:0) after 9m4s
[03:20:53.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:209:0)
[03:20:53.976] Build status: STARTED
[03:20:53.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:210:0) after 8m22s
[03:29:16.107] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:210:0)
[03:29:16.143] Build status: STARTED
[03:29:16.143] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:211:0) after 9m30s
[03:38:46.214] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:211:0)
[03:38:46.248] Build status: STARTED
[03:38:46.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:212:0) after 8m5s
[03:46:51.278] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:212:0)
[03:46:51.315] Build status: STARTED
[03:46:51.315] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:213:0) after 4m22s
[03:51:13.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:213:0)
[03:51:13.440] Build status: STARTED
[03:51:13.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:214:0) after 4m48s
[03:56:01.632] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:214:0)
[03:56:01.669] Build status: STARTED
[03:56:01.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:215:0) after 7m6s
[04:03:07.739] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:215:0)
[04:03:07.779] Build status: STARTED
[04:03:07.779] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:216:0) after 5m48s
[04:08:55.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:216:0)
[04:08:55.832] Build status: STARTED
[04:08:55.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:217:0) after 8m3s
[04:16:58.936] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:217:0)
[04:16:58.968] Build status: STARTED
[04:16:58.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:218:0) after 1m19s
[04:18:18.230] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:218:0)
[04:18:18.276] Build status: STARTED
[04:18:18.276] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:219:0) after 2m21s
[04:20:39.299] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:219:0)
[04:20:39.339] Build status: STARTED
[04:20:39.339] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:220:0) after 2m51s
[04:23:30.462] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:220:0)
[04:23:30.493] Build status: STARTED
[04:23:30.493] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:221:0) after 5m10s
[04:28:40.556] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:221:0)
[04:28:41.027] Build status: STARTED
[04:28:41.027] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:222:0) after 5m53s
[04:34:34.154] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:222:0)
[04:34:34.192] Build status: STARTED
[04:34:34.192] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:223:0) after 2m37s
[04:37:11.270] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:223:0)
[04:37:11.300] Build status: STARTED
[04:37:11.300] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:224:0) after 2m59s
[04:40:10.341] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:224:0)
[04:40:10.372] Build status: STARTED
[04:40:10.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:225:0) after 4m22s
[04:44:32.510] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:225:0)
[04:44:32.555] Build status: STARTED
[04:44:32.555] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:226:0) after 1m33s
[04:46:05.610] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:226:0)
[04:46:05.641] Build status: STARTED
[04:46:05.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:227:0) after 8m17s
[04:54:22.682] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:227:0)
[04:54:22.713] Build status: STARTED
[04:54:22.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:228:0) after 8m47s
[05:03:09.742] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:228:0)
[05:03:09.780] Build status: STARTED
[05:03:09.780] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:229:0) after 4m36s
[05:07:45.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:229:0)
[05:07:45.846] Build status: STARTED
[05:07:45.846] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:230:0) after 4m31s
[05:12:16.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:230:0)
[05:12:16.893] Build status: STARTED
[05:12:16.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:231:0) after 2m19s
[05:14:35.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:231:0)
[05:14:35.949] Build status: STARTED
[05:14:35.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:232:0) after 9m16s
[05:23:51.985] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:232:0)
[05:23:52.016] Build status: STARTED
[05:23:52.016] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:233:0) after 7m57s
[05:31:49.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:233:0)
[05:31:49.105] Build status: STARTED
[05:31:49.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:234:0) after 1m16s
[05:33:05.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:234:0)
[05:33:05.178] Build status: STARTED
[05:33:05.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:235:0) after 1m2s
[05:34:07.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:235:0)
[05:34:07.234] Build status: STARTED
[05:34:07.234] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:236:0) after 3m39s
[05:37:46.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:236:0)
[05:37:46.287] Build status: STARTED
[05:37:46.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:237:0) after 6m10s
[05:43:56.311] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:237:0)
[05:43:56.401] Build status: STARTED
[05:43:56.401] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:238:0) after 5m49s
[05:49:45.685] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:238:0)
[05:49:45.724] Build status: STARTED
[05:49:45.724] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:239:0) after 6m15s
[05:56:00.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:239:0)
[05:56:00.781] Build status: STARTED
[05:56:00.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:240:0) after 8m24s
[06:04:24.813] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:240:0)
[06:04:24.849] Build status: STARTED
[06:04:24.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:241:0) after 9m34s
[06:13:58.874] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:241:0)
[06:13:58.908] Build status: STARTED
[06:13:58.908] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:242:0) after 4m12s
[06:18:10.984] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:242:0)
[06:18:11.013] Build status: STARTED
[06:18:11.014] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:243:0) after 3m45s
[06:21:56.038] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:243:0)
[06:21:56.072] Build status: STARTED
[06:21:56.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:244:0) after 3m33s
[06:25:29.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:244:0)
[06:25:29.194] Build status: STARTED
[06:25:29.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:245:0) after 4m28s
[06:29:57.218] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:245:0)
[06:29:57.246] Build status: STARTED
[06:29:57.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:246:0) after 2m52s
[06:32:49.347] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:246:0)
[06:32:49.501] Build status: STARTED
[06:32:49.501] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:247:0) after 5m46s
[06:38:35.534] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:247:0)
[06:38:35.568] Build status: STARTED
[06:38:35.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:248:0) after 7m3s
[06:45:38.603] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:248:0)
[06:45:38.630] Build status: STARTED
[06:45:38.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:249:0) after 7m21s
[06:52:59.873] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:249:0)
[06:52:59.901] Build status: STARTED
[06:52:59.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:250:0) after 5m52s
[06:58:51.992] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:250:0)
[06:58:52.035] Build status: STARTED
[06:58:52.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:251:0) after 6m25s
[07:05:17.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:251:0)
[07:05:17.136] Build status: STARTED
[07:05:17.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:252:0) after 1m49s
[07:07:06.157] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:252:0)
[07:07:06.199] Build status: STARTED
[07:07:06.199] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:253:0) after 9m58s
[07:17:04.221] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:253:0)
[07:17:04.253] Build status: STARTED
[07:17:04.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:254:0) after 7m50s
[07:24:54.279] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:254:0)
[07:24:54.396] Build status: STARTED
[07:24:54.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:255:0) after 8m25s
[07:33:19.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:255:0)
[07:33:19.513] Build status: STARTED
[07:33:19.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:256:0) after 4m12s
[07:37:31.588] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:256:0)
[07:37:31.616] Build status: STARTED
[07:37:31.616] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:257:0) after 1m18s
[07:38:49.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:257:0)
[07:38:49.674] Build status: STARTED
[07:38:49.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:258:0) after 9m31s
[07:48:20.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:258:0)
[07:48:20.738] Build status: STARTED
[07:48:20.738] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:259:0) after 9m22s
[07:57:42.771] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:259:0)
[07:57:42.801] Build status: STARTED
[07:57:42.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996940561785958320:260:0) after 6m41s
[07:58:58.032] Received PubSub notification, asking Buildbucket for the build status
[07:58:58.065] Build:
{
"id": "8831510499833803649",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 527,
"createdBy": "project:r8",
"createTime": "2021-11-04T07:51:23.444760254Z",
"startTime": "2021-11-04T19:58:37.901201Z",
"endTime": "2021-11-05T07:58:57.145769Z",
"updateTime": "2021-11-05T07:58:57.553807Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "db7123358d03d43da321fcff3c590bb9fadbbe29",
"ref": "refs/heads/3.2"
}
}
}
[07:58:58.065] Invocation finished in 24h7m35.866326478s with status FAILED