[04:53:42.788] New invocation is queued and will start shortly
[04:53:43.941] Starting the invocation (attempt 1)
[04:53:43.996] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/f1bfb6a599285f727e96775b320639f80a4a9481"
[04:53:43.996] Popped gitiles commit info from properties and tags
[04:53:43.996] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:53:43.996] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:53:43.996] Buildbucket request:
{
"requestId": "8996226963272892848",
"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": "f1bfb6a599285f727e96775b320639f80a4a9481"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/3.2@f1bfb6a599285f727e96775b320639f80a4a9481",
"title": "f1bfb6a599285f727e96775b320639f80a4a9481",
"url": "https://r8.googlesource.com/r8/+/f1bfb6a599285f727e96775b320639f80a4a9481"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "f1bfb6a599285f727e96775b320639f80a4a9481",
"ref": "refs/heads/3.2"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8996226963272892848"
},
{
"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"
}
}
[04:53:44.518] Scheduled build:
{
"id": "8830796901258747105",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 533,
"createdBy": "project:r8",
"createTime": "2021-11-12T04:53:44.077068538Z",
"updateTime": "2021-11-12T04:53:44.077068538Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "f1bfb6a599285f727e96775b320639f80a4a9481",
"ref": "refs/heads/3.2"
}
}
}
[04:53:44.518] Task URL: https://cr-buildbucket.appspot.com/build/8830796901258747105
[04:53:44.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:2:0) after 4m1s
[04:57:45.534] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:2:0)
[04:57:45.567] Build status: SCHEDULED
[04:57:45.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:3:0) after 6m14s
[05:03:59.687] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:3:0)
[05:03:59.721] Build status: SCHEDULED
[05:03:59.721] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:4:0) after 5m9s
[05:09:08.750] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:4:0)
[05:09:08.777] Build status: SCHEDULED
[05:09:08.778] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:5:0) after 6m9s
[05:15:18.152] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:5:0)
[05:15:18.188] Build status: SCHEDULED
[05:15:18.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:6:0) after 9m39s
[05:24:57.561] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:6:0)
[05:24:57.592] Build status: SCHEDULED
[05:24:57.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:7:0) after 9m47s
[05:34:44.635] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:7:0)
[05:34:44.662] Build status: SCHEDULED
[05:34:44.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:8:0) after 6m16s
[05:41:00.677] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:8:0)
[05:41:00.713] Build status: SCHEDULED
[05:41:00.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:9:0) after 3m26s
[05:44:26.831] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:9:0)
[05:44:26.861] Build status: SCHEDULED
[05:44:26.861] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:10:0) after 6m23s
[05:50:50.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:10:0)
[05:50:50.061] Build status: SCHEDULED
[05:50:50.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:11:0) after 1m49s
[05:52:39.077] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:11:0)
[05:52:39.113] Build status: SCHEDULED
[05:52:39.113] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:12:0) after 9m42s
[06:02:21.132] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:12:0)
[06:02:21.172] Build status: SCHEDULED
[06:02:21.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:13:0) after 1m40s
[06:04:01.204] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:13:0)
[06:04:01.244] Build status: SCHEDULED
[06:04:01.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:14:0) after 6m57s
[06:10:58.267] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:14:0)
[06:10:58.311] Build status: SCHEDULED
[06:10:58.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:15:0) after 3m16s
[06:14:14.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:15:0)
[06:14:14.380] Build status: SCHEDULED
[06:14:14.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:16:0) after 9m32s
[06:23:46.473] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:16:0)
[06:23:46.503] Build status: SCHEDULED
[06:23:46.503] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:17:0) after 4m33s
[06:28:19.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:17:0)
[06:28:19.556] Build status: SCHEDULED
[06:28:19.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:18:0) after 1m37s
[06:29:56.668] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:18:0)
[06:29:56.738] Build status: SCHEDULED
[06:29:56.738] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:19:0) after 8m10s
[06:38:06.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:19:0)
[06:38:06.891] Build status: SCHEDULED
[06:38:06.891] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:20:0) after 2m33s
[06:40:40.093] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:20:0)
[06:40:40.152] Build status: SCHEDULED
[06:40:40.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:21:0) after 2m17s
[06:42:57.172] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:21:0)
[06:42:57.355] Build status: SCHEDULED
[06:42:57.355] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:22:0) after 8m29s
[06:51:26.374] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:22:0)
[06:51:26.402] Build status: SCHEDULED
[06:51:26.402] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:23:0) after 7m40s
[06:59:06.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:23:0)
[06:59:06.451] Build status: SCHEDULED
[06:59:06.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:24:0) after 7m47s
[07:06:53.618] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:24:0)
[07:06:53.656] Build status: SCHEDULED
[07:06:53.656] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:25:0) after 6m51s
[07:13:44.686] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:25:0)
[07:13:44.723] Build status: SCHEDULED
[07:13:44.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:26:0) after 5m33s
[07:19:17.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:26:0)
[07:19:17.772] Build status: SCHEDULED
[07:19:17.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:27:0) after 8m8s
[07:27:25.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:27:0)
[07:27:25.825] Build status: SCHEDULED
[07:27:25.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:28:0) after 2m1s
[07:29:26.843] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:28:0)
[07:29:26.869] Build status: SCHEDULED
[07:29:26.869] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:29:0) after 2m42s
[07:32:08.944] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:29:0)
[07:32:08.976] Build status: SCHEDULED
[07:32:08.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:30:0) after 6m34s
[07:38:43.001] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:30:0)
[07:38:43.037] Build status: SCHEDULED
[07:38:43.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:31:0) after 7m21s
[07:42:26.131] Received PubSub notification, asking Buildbucket for the build status
[07:42:26.161] Build status: STARTED
[07:46:04.167] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:31:0)
[07:46:04.200] Build status: STARTED
[07:46:04.200] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:33:0) after 7m47s
[07:53:51.214] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:33:0)
[07:53:51.247] Build status: STARTED
[07:53:51.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:34:0) after 5m26s
[07:59:17.264] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:34:0)
[07:59:17.318] Build status: STARTED
[07:59:17.318] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:35:0) after 3m8s
[08:02:25.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:35:0)
[08:02:25.389] Build status: STARTED
[08:02:25.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:36:0) after 2m14s
[08:04:39.496] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:36:0)
[08:04:39.532] Build status: STARTED
[08:04:39.532] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:37:0) after 5m44s
[08:10:23.541] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:37:0)
[08:10:23.582] Build status: STARTED
[08:10:23.582] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:38:0) after 9m45s
[08:20:08.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:38:0)
[08:20:08.629] Build status: STARTED
[08:20:08.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:39:0) after 7m19s
[08:27:27.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:39:0)
[08:27:27.835] Build status: STARTED
[08:27:27.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:40:0) after 6m4s
[08:33:31.860] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:40:0)
[08:33:31.899] Build status: STARTED
[08:33:31.899] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:41:0) after 3m34s
[08:37:05.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:41:0)
[08:37:05.953] Build status: STARTED
[08:37:05.953] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:42:0) after 8m5s
[08:45:11.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:42:0)
[08:45:11.182] Build status: STARTED
[08:45:11.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:43:0) after 9m34s
[08:54:45.398] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:43:0)
[08:54:45.431] Build status: STARTED
[08:54:45.431] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:44:0) after 7m6s
[09:01:51.453] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:44:0)
[09:01:51.500] Build status: STARTED
[09:01:51.500] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:45:0) after 5m13s
[09:07:04.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:45:0)
[09:07:04.758] Build status: STARTED
[09:07:04.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:46:0) after 1m1s
[09:08:05.882] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:46:0)
[09:08:05.944] Build status: STARTED
[09:08:05.944] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:47:0) after 5m18s
[09:13:24.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:47:0)
[09:13:24.049] Build status: STARTED
[09:13:24.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:48:0) after 1m59s
[09:15:23.026] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:48:0)
[09:15:23.055] Build status: STARTED
[09:15:23.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:49:0) after 3m21s
[09:18:44.109] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:49:0)
[09:18:44.137] Build status: STARTED
[09:18:44.137] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:50:0) after 3m30s
[09:22:14.263] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:50:0)
[09:22:14.294] Build status: STARTED
[09:22:14.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:51:0) after 2m10s
[09:24:24.359] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:51:0)
[09:24:24.435] Build status: STARTED
[09:24:24.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:52:0) after 2m9s
[09:26:33.628] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:52:0)
[09:26:33.663] Build status: STARTED
[09:26:33.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:53:0) after 8m41s
[09:35:14.848] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:53:0)
[09:35:14.877] Build status: STARTED
[09:35:14.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:54:0) after 7m5s
[09:42:19.895] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:54:0)
[09:42:19.929] Build status: STARTED
[09:42:19.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:55:0) after 3m7s
[09:45:26.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:55:0)
[09:45:27.000] Build status: STARTED
[09:45:27.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:56:0) after 8m7s
[09:53:34.053] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:56:0)
[09:53:34.122] Build status: STARTED
[09:53:34.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:57:0) after 7m20s
[10:00:54.149] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:57:0)
[10:00:54.268] Build status: STARTED
[10:00:54.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:58:0) after 6m26s
[10:07:20.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:58:0)
[10:07:20.324] Build status: STARTED
[10:07:20.324] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:59:0) after 6m29s
[10:13:49.351] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:59:0)
[10:13:49.385] Build status: STARTED
[10:13:49.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:60:0) after 8m10s
[10:21:59.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:60:0)
[10:21:59.594] Build status: STARTED
[10:21:59.594] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:61:0) after 2m33s
[10:24:32.657] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:61:0)
[10:24:32.689] Build status: STARTED
[10:24:32.689] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:62:0) after 7m54s
[10:32:26.736] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:62:0)
[10:32:26.774] Build status: STARTED
[10:32:26.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:63:0) after 2m2s
[10:34:28.799] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:63:0)
[10:34:28.841] Build status: STARTED
[10:34:28.841] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:64:0) after 3m4s
[10:37:32.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:64:0)
[10:37:32.914] Build status: STARTED
[10:37:32.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:65:0) after 2m32s
[10:40:04.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:65:0)
[10:40:05.015] Build status: STARTED
[10:40:05.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:66:0) after 5m17s
[10:45:22.034] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:66:0)
[10:45:22.071] Build status: STARTED
[10:45:22.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:67:0) after 2m11s
[10:47:33.093] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:67:0)
[10:47:33.126] Build status: STARTED
[10:47:33.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:68:0) after 8m35s
[10:56:08.240] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:68:0)
[10:56:08.271] Build status: STARTED
[10:56:08.271] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:69:0) after 1m18s
[10:57:26.393] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:69:0)
[10:57:26.442] Build status: STARTED
[10:57:26.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:70:0) after 3m43s
[11:01:09.463] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:70:0)
[11:01:09.494] Build status: STARTED
[11:01:09.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:71:0) after 1m38s
[11:02:47.520] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:71:0)
[11:02:47.556] Build status: STARTED
[11:02:47.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:72:0) after 5m49s
[11:08:36.580] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:72:0)
[11:08:36.630] Build status: STARTED
[11:08:36.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:73:0) after 1m20s
[11:09:56.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:73:0)
[11:09:56.682] Build status: STARTED
[11:09:56.682] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:74:0) after 4m28s
[11:14:24.704] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:74:0)
[11:14:24.741] Build status: STARTED
[11:14:24.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:75:0) after 7m32s
[11:21:56.990] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:75:0)
[11:21:57.047] Build status: STARTED
[11:21:57.047] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:76:0) after 4m39s
[11:26:36.177] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:76:0)
[11:26:36.213] Build status: STARTED
[11:26:36.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:77:0) after 3m10s
[11:29:46.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:77:0)
[11:29:46.383] Build status: STARTED
[11:29:46.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:78:0) after 2m38s
[11:32:24.479] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:78:0)
[11:32:24.512] Build status: STARTED
[11:32:24.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:79:0) after 1m54s
[11:34:18.550] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:79:0)
[11:34:18.578] Build status: STARTED
[11:34:18.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:80:0) after 6m22s
[11:40:40.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:80:0)
[11:40:40.639] Build status: STARTED
[11:40:40.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:81:0) after 3m17s
[11:43:57.683] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:81:0)
[11:43:57.713] Build status: STARTED
[11:43:57.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:82:0) after 9m16s
[11:53:13.985] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:82:0)
[11:53:14.033] Build status: STARTED
[11:53:14.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:83:0) after 9m28s
[12:02:42.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:83:0)
[12:02:42.093] Build status: STARTED
[12:02:42.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:84:0) after 3m14s
[12:05:56.114] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:84:0)
[12:05:56.218] Build status: STARTED
[12:05:56.218] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:85:0) after 8m43s
[12:14:39.433] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:85:0)
[12:14:39.462] Build status: STARTED
[12:14:39.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:86:0) after 5m3s
[12:19:42.482] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:86:0)
[12:19:42.512] Build status: STARTED
[12:19:42.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:87:0) after 6m37s
[12:26:19.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:87:0)
[12:26:19.757] Build status: STARTED
[12:26:19.757] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:88:0) after 2m35s
[12:28:54.879] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:88:0)
[12:28:54.915] Build status: STARTED
[12:28:54.915] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:89:0) after 1m56s
[12:30:51.055] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:89:0)
[12:30:51.086] Build status: STARTED
[12:30:51.086] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:90:0) after 5m42s
[12:36:33.109] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:90:0)
[12:36:33.142] Build status: STARTED
[12:36:33.143] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:91:0) after 3m51s
[12:40:24.270] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:91:0)
[12:40:24.360] Build status: STARTED
[12:40:24.360] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:92:0) after 7m24s
[12:47:48.482] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:92:0)
[12:47:48.512] Build status: STARTED
[12:47:48.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:93:0) after 8m31s
[12:56:19.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:93:0)
[12:56:19.566] Build status: STARTED
[12:56:19.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8996226963272892848:94:0) after 5m21s
[12:59:55.828] Received PubSub notification, asking Buildbucket for the build status
[12:59:55.858] Build:
{
"id": "8830796901258747105",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 533,
"createdBy": "project:r8",
"createTime": "2021-11-12T04:53:44.077068538Z",
"startTime": "2021-11-12T07:42:23.585731Z",
"endTime": "2021-11-12T12:59:54.169717Z",
"updateTime": "2021-11-12T12:59:55.110272Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "f1bfb6a599285f727e96775b320639f80a4a9481",
"ref": "refs/heads/3.2"
}
}
}
[12:59:55.858] Invocation finished in 8h6m13.084518405s with status SUCCEEDED