[19:13:39.514] New invocation is queued and will start shortly
[19:13:40.895] Starting the invocation (attempt 1)
[19:13:40.930] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/0b5e2704acedd2b6c5e545c986c7613dbe2a6211"
[19:13:40.930] Popped gitiles commit info from properties and tags
[19:13:40.930] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:13:40.930] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:13:40.930] Buildbucket request:
{
"requestId": "8995176293554412720",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-none"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "0b5e2704acedd2b6c5e545c986c7613dbe2a6211"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@0b5e2704acedd2b6c5e545c986c7613dbe2a6211",
"title": "0b5e2704acedd2b6c5e545c986c7613dbe2a6211",
"url": "https://r8.googlesource.com/r8/+/0b5e2704acedd2b6c5e545c986c7613dbe2a6211"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "0b5e2704acedd2b6c5e545c986c7613dbe2a6211",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8995176293554412720"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-none"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:13:41.367] Scheduled build:
{
"id": "8829746231322380561",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-none"
},
"number": 1052,
"createdBy": "project:r8",
"createTime": "2021-11-23T19:13:41.010569176Z",
"updateTime": "2021-11-23T19:13:41.010569176Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "0b5e2704acedd2b6c5e545c986c7613dbe2a6211",
"ref": "refs/heads/main"
}
}
}
[19:13:41.367] Task URL: https://cr-buildbucket.appspot.com/build/8829746231322380561
[19:13:41.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:2:0) after 7m54s
[19:21:35.531] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:2:0)
[19:21:35.604] Build status: SCHEDULED
[19:21:35.604] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:3:0) after 2m47s
[19:24:22.867] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:3:0)
[19:24:22.902] Build status: SCHEDULED
[19:24:22.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:4:0) after 6m48s
[19:31:11.297] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:4:0)
[19:31:11.372] Build status: SCHEDULED
[19:31:11.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:5:0) after 3m20s
[19:34:31.490] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:5:0)
[19:34:31.521] Build status: SCHEDULED
[19:34:31.521] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:6:0) after 2m50s
[19:37:21.632] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:6:0)
[19:37:21.663] Build status: SCHEDULED
[19:37:21.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:7:0) after 9m34s
[19:46:56.297] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:7:0)
[19:46:56.335] Build status: SCHEDULED
[19:46:56.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:8:0) after 3m56s
[19:50:52.773] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:8:0)
[19:50:52.815] Build status: SCHEDULED
[19:50:52.815] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:9:0) after 9m38s
[20:00:31.053] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:9:0)
[20:00:31.087] Build status: SCHEDULED
[20:00:31.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:10:0) after 5m13s
[20:05:44.286] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:10:0)
[20:05:44.367] Build status: SCHEDULED
[20:05:44.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:11:0) after 4m48s
[20:10:33.091] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:11:0)
[20:10:33.122] Build status: SCHEDULED
[20:10:33.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:12:0) after 4m58s
[20:15:31.107] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:12:0)
[20:15:31.140] Build status: SCHEDULED
[20:15:31.140] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:13:0) after 4m26s
[20:19:57.172] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:13:0)
[20:19:57.216] Build status: SCHEDULED
[20:19:57.216] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:14:0) after 7m31s
[20:27:28.631] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:14:0)
[20:27:28.665] Build status: SCHEDULED
[20:27:28.665] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:15:0) after 7m30s
[20:34:58.967] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:15:0)
[20:34:59.008] Build status: SCHEDULED
[20:34:59.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:16:0) after 6m20s
[20:41:19.271] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:16:0)
[20:41:19.356] Build status: SCHEDULED
[20:41:19.356] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:17:0) after 6m52s
[20:48:11.377] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:17:0)
[20:48:11.409] Build status: SCHEDULED
[20:48:11.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:18:0) after 8m12s
[20:56:23.442] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:18:0)
[20:56:23.480] Build status: SCHEDULED
[20:56:23.480] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:19:0) after 2m26s
[20:58:49.498] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:19:0)
[20:58:49.551] Build status: SCHEDULED
[20:58:49.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:20:0) after 2m38s
[21:01:27.689] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:20:0)
[21:01:27.745] Build status: SCHEDULED
[21:01:27.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:21:0) after 4m39s
[21:06:06.784] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:21:0)
[21:06:06.819] Build status: SCHEDULED
[21:06:06.819] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:22:0) after 2m7s
[21:08:13.927] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:22:0)
[21:08:13.959] Build status: SCHEDULED
[21:08:13.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:23:0) after 1m15s
[21:09:28.965] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:23:0)
[21:09:28.997] Build status: SCHEDULED
[21:09:28.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:24:0) after 1m42s
[21:11:11.135] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:24:0)
[21:11:11.162] Build status: SCHEDULED
[21:11:11.162] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:25:0) after 5m18s
[21:16:29.472] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:25:0)
[21:16:29.505] Build status: SCHEDULED
[21:16:29.505] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:26:0) after 3m5s
[21:19:34.608] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:26:0)
[21:19:34.649] Build status: SCHEDULED
[21:19:34.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:27:0) after 8m24s
[21:27:58.762] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:27:0)
[21:27:58.800] Build status: SCHEDULED
[21:27:58.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:28:0) after 9m50s
[21:37:48.950] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:28:0)
[21:37:48.992] Build status: SCHEDULED
[21:37:48.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:29:0) after 6m54s
[21:44:42.978] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:29:0)
[21:44:43.011] Build status: SCHEDULED
[21:44:43.011] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:30:0) after 1m14s
[21:45:57.092] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:30:0)
[21:45:57.161] Build status: SCHEDULED
[21:45:57.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:31:0) after 2m55s
[21:48:52.491] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:31:0)
[21:48:52.529] Build status: SCHEDULED
[21:48:52.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:32:0) after 4m48s
[21:53:40.547] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:32:0)
[21:53:40.578] Build status: SCHEDULED
[21:53:40.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:33:0) after 2m31s
[21:56:11.687] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:33:0)
[21:56:11.723] Build status: SCHEDULED
[21:56:11.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:34:0) after 7m50s
[22:04:01.745] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:34:0)
[22:04:01.784] Build status: SCHEDULED
[22:04:01.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:35:0) after 2m7s
[22:06:08.804] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:35:0)
[22:06:08.890] Build status: SCHEDULED
[22:06:08.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:36:0) after 8m49s
[22:14:58.007] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:36:0)
[22:14:58.110] Build status: SCHEDULED
[22:14:58.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:37:0) after 4m3s
[22:19:02.048] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:37:0)
[22:19:02.089] Build status: SCHEDULED
[22:19:02.089] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:38:0) after 8m40s
[22:27:42.195] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:38:0)
[22:27:42.380] Build status: SCHEDULED
[22:27:42.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:39:0) after 2m18s
[22:30:00.580] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:39:0)
[22:30:00.652] Build status: SCHEDULED
[22:30:00.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:40:0) after 5m8s
[22:35:08.783] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:40:0)
[22:35:08.901] Build status: SCHEDULED
[22:35:08.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:41:0) after 3m33s
[22:38:42.021] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:41:0)
[22:38:42.067] Build status: SCHEDULED
[22:38:42.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:42:0) after 5m9s
[22:43:51.099] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:42:0)
[22:43:51.135] Build status: SCHEDULED
[22:43:51.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:43:0) after 8m29s
[22:52:20.162] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:43:0)
[22:52:20.191] Build status: SCHEDULED
[22:52:20.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:44:0) after 6m45s
[22:59:05.669] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:44:0)
[22:59:05.768] Build status: SCHEDULED
[22:59:05.768] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:45:0) after 9m13s
[23:08:19.085] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:45:0)
[23:08:19.131] Build status: SCHEDULED
[23:08:19.131] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:46:0) after 6m21s
[23:14:40.267] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:46:0)
[23:14:40.296] Build status: SCHEDULED
[23:14:40.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:47:0) after 3m55s
[23:18:35.423] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:47:0)
[23:18:35.452] Build status: SCHEDULED
[23:18:35.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:48:0) after 7m36s
[23:26:11.538] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:48:0)
[23:26:11.574] Build status: SCHEDULED
[23:26:11.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:49:0) after 9m44s
[23:35:55.640] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:49:0)
[23:35:55.674] Build status: SCHEDULED
[23:35:55.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:50:0) after 4m28s
[23:40:23.717] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:50:0)
[23:40:23.791] Build status: SCHEDULED
[23:40:23.791] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:51:0) after 7m32s
[23:47:56.052] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:51:0)
[23:47:56.094] Build status: SCHEDULED
[23:47:56.094] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:52:0) after 4m6s
[23:52:02.187] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:52:0)
[23:52:02.232] Build status: SCHEDULED
[23:52:02.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:53:0) after 1m44s
[23:53:46.392] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:53:0)
[23:53:46.432] Build status: SCHEDULED
[23:53:46.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:54:0) after 7m26s
[00:01:12.454] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:54:0)
[00:01:12.492] Build status: SCHEDULED
[00:01:12.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:55:0) after 1m57s
[00:03:09.989] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:55:0)
[00:03:10.045] Build status: SCHEDULED
[00:03:10.045] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:56:0) after 2m48s
[00:05:58.264] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:56:0)
[00:05:58.319] Build status: SCHEDULED
[00:05:58.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:57:0) after 3m45s
[00:09:43.427] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:57:0)
[00:09:43.456] Build status: SCHEDULED
[00:09:43.456] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:58:0) after 6m1s
[00:15:44.633] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:58:0)
[00:15:44.670] Build status: SCHEDULED
[00:15:44.670] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:59:0) after 5m21s
[00:21:05.688] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:59:0)
[00:21:05.733] Build status: SCHEDULED
[00:21:05.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:60:0) after 3m17s
[00:24:23.258] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:60:0)
[00:24:23.354] Build status: SCHEDULED
[00:24:23.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:61:0) after 2m17s
[00:26:40.405] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:61:0)
[00:26:40.565] Build status: SCHEDULED
[00:26:40.565] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:62:0) after 3m26s
[00:30:06.607] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:62:0)
[00:30:06.649] Build status: SCHEDULED
[00:30:06.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:63:0) after 2m37s
[00:32:44.204] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:63:0)
[00:32:44.235] Build status: SCHEDULED
[00:32:44.235] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:64:0) after 6m58s
[00:39:42.477] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:64:0)
[00:39:42.532] Build status: SCHEDULED
[00:39:42.532] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:65:0) after 6m59s
[00:46:41.553] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:65:0)
[00:46:41.587] Build status: SCHEDULED
[00:46:41.587] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:66:0) after 6m11s
[00:52:52.607] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:66:0)
[00:52:52.644] Build status: SCHEDULED
[00:52:52.644] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:67:0) after 5m28s
[00:58:20.674] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:67:0)
[00:58:20.712] Build status: SCHEDULED
[00:58:20.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:68:0) after 1m8s
[00:59:28.858] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:68:0)
[00:59:28.886] Build status: SCHEDULED
[00:59:28.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:69:0) after 1m57s
[01:01:25.994] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:69:0)
[01:01:26.023] Build status: SCHEDULED
[01:01:26.023] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:70:0) after 4m47s
[01:06:13.289] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:70:0)
[01:06:13.327] Build status: SCHEDULED
[01:06:13.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:71:0) after 8m29s
[01:14:42.586] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:71:0)
[01:14:42.622] Build status: SCHEDULED
[01:14:42.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:72:0) after 7m37s
[01:22:19.782] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:72:0)
[01:22:19.820] Build status: SCHEDULED
[01:22:19.820] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:73:0) after 3m53s
[01:26:12.992] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:73:0)
[01:26:13.088] Build status: SCHEDULED
[01:26:13.088] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:74:0) after 7m58s
[01:34:11.318] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:74:0)
[01:34:11.350] Build status: SCHEDULED
[01:34:11.350] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:75:0) after 3m36s
[01:37:47.372] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:75:0)
[01:37:47.417] Build status: SCHEDULED
[01:37:47.417] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:76:0) after 5m53s
[01:43:40.453] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:76:0)
[01:43:40.574] Build status: SCHEDULED
[01:43:40.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:77:0) after 8m39s
[01:52:19.599] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:77:0)
[01:52:19.629] Build status: SCHEDULED
[01:52:19.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:78:0) after 3m29s
[01:55:48.652] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:78:0)
[01:55:48.686] Build status: SCHEDULED
[01:55:48.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:79:0) after 5m42s
[02:01:30.897] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:79:0)
[02:01:30.927] Build status: SCHEDULED
[02:01:30.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:80:0) after 7m31s
[02:09:02.010] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:80:0)
[02:09:02.069] Build status: SCHEDULED
[02:09:02.069] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:81:0) after 5m51s
[02:14:53.515] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:81:0)
[02:14:53.654] Build status: SCHEDULED
[02:14:53.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:82:0) after 6m31s
[02:21:24.712] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:82:0)
[02:21:24.759] Build status: SCHEDULED
[02:21:24.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:83:0) after 4m6s
[02:25:30.750] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:83:0)
[02:25:30.789] Build status: SCHEDULED
[02:25:30.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:84:0) after 5m16s
[02:30:46.878] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:84:0)
[02:30:46.914] Build status: SCHEDULED
[02:30:46.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:85:0) after 7m33s
[02:38:19.935] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:85:0)
[02:38:19.987] Build status: SCHEDULED
[02:38:19.987] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:86:0) after 7m12s
[02:45:32.240] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:86:0)
[02:45:32.275] Build status: SCHEDULED
[02:45:32.275] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:87:0) after 8m46s
[02:54:18.310] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:87:0)
[02:54:18.342] Build status: SCHEDULED
[02:54:18.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:88:0) after 7m16s
[03:01:34.599] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:88:0)
[03:01:34.635] Build status: SCHEDULED
[03:01:34.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:89:0) after 8m52s
[03:10:26.723] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:89:0)
[03:10:26.776] Build status: SCHEDULED
[03:10:26.776] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:90:0) after 5m58s
[03:16:24.758] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:90:0)
[03:16:24.792] Build status: SCHEDULED
[03:16:24.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:91:0) after 1m36s
[03:18:01.178] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:91:0)
[03:18:01.214] Build status: SCHEDULED
[03:18:01.214] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:92:0) after 9m26s
[03:27:27.223] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:92:0)
[03:27:27.256] Build status: SCHEDULED
[03:27:27.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:93:0) after 1m51s
[03:29:18.258] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:93:0)
[03:29:18.287] Build status: SCHEDULED
[03:29:18.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:94:0) after 9m23s
[03:38:41.586] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:94:0)
[03:38:41.629] Build status: SCHEDULED
[03:38:41.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:95:0) after 5m27s
[03:44:08.648] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:95:0)
[03:44:08.694] Build status: SCHEDULED
[03:44:08.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:96:0) after 6m24s
[03:50:32.713] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:96:0)
[03:50:32.746] Build status: SCHEDULED
[03:50:32.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:97:0) after 9m53s
[04:00:25.786] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:97:0)
[04:00:25.823] Build status: SCHEDULED
[04:00:25.823] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:98:0) after 1m15s
[04:01:40.867] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:98:0)
[04:01:40.901] Build status: SCHEDULED
[04:01:40.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:99:0) after 2m53s
[04:04:33.951] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:99:0)
[04:04:33.989] Build status: SCHEDULED
[04:04:33.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:100:0) after 3m48s
[04:08:22.023] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:100:0)
[04:08:22.087] Build status: SCHEDULED
[04:08:22.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:101:0) after 6m45s
[04:15:07.107] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:101:0)
[04:15:07.136] Build status: SCHEDULED
[04:15:07.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:102:0) after 3m20s
[04:18:27.198] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:102:0)
[04:18:27.231] Build status: SCHEDULED
[04:18:27.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:103:0) after 7m18s
[04:25:45.279] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:103:0)
[04:25:45.310] Build status: SCHEDULED
[04:25:45.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:104:0) after 7m16s
[04:33:01.560] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:104:0)
[04:33:01.592] Build status: SCHEDULED
[04:33:01.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:105:0) after 7m29s
[04:40:30.625] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:105:0)
[04:40:30.658] Build status: SCHEDULED
[04:40:30.658] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:106:0) after 6m10s
[04:46:40.676] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:106:0)
[04:46:40.706] Build status: SCHEDULED
[04:46:40.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:107:0) after 3m55s
[04:50:35.831] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:107:0)
[04:50:35.863] Build status: SCHEDULED
[04:50:35.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:108:0) after 3m21s
[04:53:56.884] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:108:0)
[04:53:57.055] Build status: SCHEDULED
[04:53:57.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:109:0) after 1m30s
[04:55:27.074] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:109:0)
[04:55:27.106] Build status: SCHEDULED
[04:55:27.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:110:0) after 2m3s
[04:57:30.158] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:110:0)
[04:57:30.189] Build status: SCHEDULED
[04:57:30.189] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:111:0) after 8m33s
[05:06:03.383] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:111:0)
[05:06:03.561] Build status: SCHEDULED
[05:06:03.561] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:112:0) after 6m2s
[05:12:05.858] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:112:0)
[05:12:05.914] Build status: SCHEDULED
[05:12:05.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:113:0) after 9m45s
[05:21:51.046] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:113:0)
[05:21:51.090] Build status: SCHEDULED
[05:21:51.090] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:114:0) after 6m14s
[05:28:05.275] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:114:0)
[05:28:05.305] Build status: SCHEDULED
[05:28:05.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:115:0) after 7m6s
[05:35:11.324] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:115:0)
[05:35:11.355] Build status: SCHEDULED
[05:35:11.355] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:116:0) after 7m22s
[05:42:33.373] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:116:0)
[05:42:33.409] Build status: SCHEDULED
[05:42:33.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:117:0) after 6m17s
[05:48:50.619] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:117:0)
[05:48:50.699] Build status: SCHEDULED
[05:48:50.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:118:0) after 9m58s
[05:58:48.717] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:118:0)
[05:58:48.751] Build status: SCHEDULED
[05:58:48.751] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:119:0) after 4m46s
[06:02:55.726] Received PubSub notification, asking Buildbucket for the build status
[06:02:55.759] Build status: STARTED
[06:03:34.872] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:119:0)
[06:03:34.902] Build status: STARTED
[06:03:34.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:121:0) after 6m25s
[06:10:00.022] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:121:0)
[06:10:00.053] Build status: STARTED
[06:10:00.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:122:0) after 4m29s
[06:14:29.319] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:122:0)
[06:14:29.362] Build status: STARTED
[06:14:29.362] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:123:0) after 3m13s
[06:17:42.555] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:123:0)
[06:17:42.599] Build status: STARTED
[06:17:42.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:124:0) after 8m7s
[06:25:49.625] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:124:0)
[06:25:49.660] Build status: STARTED
[06:25:49.660] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:125:0) after 3m47s
[06:29:36.715] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:125:0)
[06:29:36.750] Build status: STARTED
[06:29:36.750] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:126:0) after 7m3s
[06:36:39.772] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:126:0)
[06:36:39.806] Build status: STARTED
[06:36:39.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:127:0) after 4m39s
[06:41:18.889] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:127:0)
[06:41:18.920] Build status: STARTED
[06:41:18.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:128:0) after 4m22s
[06:45:40.982] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:128:0)
[06:45:41.014] Build status: STARTED
[06:45:41.014] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:129:0) after 2m8s
[06:47:49.036] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:129:0)
[06:47:49.066] Build status: STARTED
[06:47:49.066] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:130:0) after 7m25s
[06:55:14.100] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:130:0)
[06:55:14.233] Build status: STARTED
[06:55:14.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:131:0) after 7m8s
[07:02:22.268] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:131:0)
[07:02:22.299] Build status: STARTED
[07:02:22.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:132:0) after 3m54s
[07:06:16.549] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:132:0)
[07:06:16.588] Build status: STARTED
[07:06:16.588] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:133:0) after 8m27s
[07:14:43.997] Handling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:133:0)
[07:14:44.033] Build status: STARTED
[07:14:44.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-none:8995176293554412720:134:0) after 8m59s
[07:14:45.697] Received PubSub notification, asking Buildbucket for the build status
[07:14:45.729] Build:
{
"id": "8829746231322380561",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-none"
},
"number": 1052,
"createdBy": "project:r8",
"createTime": "2021-11-23T19:13:41.010569176Z",
"startTime": "2021-11-24T06:02:54.811977Z",
"endTime": "2021-11-24T07:14:45.063423Z",
"updateTime": "2021-11-24T07:14:45.483227Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "0b5e2704acedd2b6c5e545c986c7613dbe2a6211",
"ref": "refs/heads/main"
}
}
}
[07:14:45.729] Invocation finished in 12h1m6.230378873s with status SUCCEEDED