[19:14:13.144] New invocation is queued and will start shortly
[19:14:16.388] Starting the invocation (attempt 1)
[19:14:16.415] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/5de6d7daaee1579dfe9f19b044cf3bc247e06050"
[19:14:16.415] Popped gitiles commit info from properties and tags
[19:14:16.415] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:14:16.415] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:14:16.415] Buildbucket request:
{
"requestId": "8954770011266875920",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-none_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8954770011266875920",
"job": "r8/linux-none_release",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/8.1",
"repo": "https://r8.googlesource.com/r8",
"revision": "5de6d7daaee1579dfe9f19b044cf3bc247e06050"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/8.1@5de6d7daaee1579dfe9f19b044cf3bc247e06050",
"title": "5de6d7daaee1579dfe9f19b044cf3bc247e06050",
"url": "https://r8.googlesource.com/r8/+/5de6d7daaee1579dfe9f19b044cf3bc247e06050"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "5de6d7daaee1579dfe9f19b044cf3bc247e06050",
"ref": "refs/heads/8.1"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8954770011266875920"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-none_release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:14:16.879] Scheduled build:
{
"id": "8789339947071561473",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-none_release"
},
"number": 445,
"createdBy": "project:r8",
"createTime": "2023-02-12T19:14:16.522574813Z",
"updateTime": "2023-02-12T19:14:16.522574813Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "5de6d7daaee1579dfe9f19b044cf3bc247e06050",
"ref": "refs/heads/8.1"
}
}
}
[19:14:16.879] Task URL: https://cr-buildbucket.appspot.com/build/8789339947071561473
[19:14:16.879] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:2:0) after 9m51s
[19:24:07.922] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:2:0)
[19:24:07.951] Build status: SCHEDULED
[19:24:07.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:3:0) after 1m33s
[19:25:40.970] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:3:0)
[19:25:40.991] Build status: SCHEDULED
[19:25:40.991] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:4:0) after 7m51s
[19:33:32.478] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:4:0)
[19:33:32.501] Build status: SCHEDULED
[19:33:32.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:5:0) after 1m48s
[19:35:20.520] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:5:0)
[19:35:20.547] Build status: SCHEDULED
[19:35:20.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:6:0) after 7m48s
[19:43:08.564] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:6:0)
[19:43:08.593] Build status: SCHEDULED
[19:43:08.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:7:0) after 5m53s
[19:49:01.629] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:7:0)
[19:49:01.653] Build status: SCHEDULED
[19:49:01.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:8:0) after 7m0s
[19:56:01.681] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:8:0)
[19:56:01.741] Build status: SCHEDULED
[19:56:01.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:9:0) after 1m35s
[19:57:36.758] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:9:0)
[19:57:36.801] Build status: SCHEDULED
[19:57:36.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:10:0) after 2m27s
[20:00:04.007] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:10:0)
[20:00:04.028] Build status: SCHEDULED
[20:00:04.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:11:0) after 6m22s
[20:06:26.109] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:11:0)
[20:06:26.202] Build status: SCHEDULED
[20:06:26.202] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:12:0) after 2m36s
[20:09:02.266] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:12:0)
[20:09:02.295] Build status: SCHEDULED
[20:09:02.295] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:13:0) after 9m43s
[20:18:45.300] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:13:0)
[20:18:45.326] Build status: SCHEDULED
[20:18:45.326] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:14:0) after 9m41s
[20:28:26.446] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:14:0)
[20:28:26.466] Build status: SCHEDULED
[20:28:26.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:15:0) after 4m55s
[20:33:21.668] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:15:0)
[20:33:21.704] Build status: SCHEDULED
[20:33:21.704] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:16:0) after 5m52s
[20:39:13.764] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:16:0)
[20:39:13.786] Build status: SCHEDULED
[20:39:13.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:17:0) after 6m25s
[20:45:38.935] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:17:0)
[20:45:38.958] Build status: SCHEDULED
[20:45:38.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:18:0) after 1m59s
[20:47:38.049] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:18:0)
[20:47:38.072] Build status: SCHEDULED
[20:47:38.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:19:0) after 5m59s
[20:53:37.091] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:19:0)
[20:53:37.127] Build status: SCHEDULED
[20:53:37.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:20:0) after 9m3s
[21:02:40.143] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:20:0)
[21:02:40.163] Build status: SCHEDULED
[21:02:40.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:21:0) after 7m6s
[21:09:46.179] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:21:0)
[21:09:46.198] Build status: SCHEDULED
[21:09:46.199] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:22:0) after 3m30s
[21:13:16.224] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:22:0)
[21:13:16.244] Build status: SCHEDULED
[21:13:16.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:23:0) after 4m54s
[21:18:10.262] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:23:0)
[21:18:10.286] Build status: SCHEDULED
[21:18:10.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:24:0) after 2m52s
[21:21:02.342] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:24:0)
[21:21:02.360] Build status: SCHEDULED
[21:21:02.360] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:25:0) after 5m5s
[21:26:07.376] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:25:0)
[21:26:07.404] Build status: SCHEDULED
[21:26:07.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:26:0) after 4m51s
[21:30:58.433] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:26:0)
[21:30:58.476] Build status: SCHEDULED
[21:30:58.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:27:0) after 2m28s
[21:33:26.497] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:27:0)
[21:33:26.535] Build status: SCHEDULED
[21:33:26.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:28:0) after 5m40s
[21:39:06.565] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:28:0)
[21:39:06.598] Build status: SCHEDULED
[21:39:06.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:29:0) after 2m12s
[21:41:18.884] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:29:0)
[21:41:18.907] Build status: SCHEDULED
[21:41:18.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:30:0) after 4m39s
[21:45:57.932] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:30:0)
[21:45:57.958] Build status: SCHEDULED
[21:45:57.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:31:0) after 7m23s
[21:53:20.976] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:31:0)
[21:53:21.000] Build status: SCHEDULED
[21:53:21.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:32:0) after 1m44s
[21:55:05.017] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:32:0)
[21:55:05.312] Build status: SCHEDULED
[21:55:05.312] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:33:0) after 4m57s
[22:00:02.302] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:33:0)
[22:00:02.337] Build status: SCHEDULED
[22:00:02.337] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:34:0) after 8m19s
[22:08:21.372] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:34:0)
[22:08:21.409] Build status: SCHEDULED
[22:08:21.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:35:0) after 8m33s
[22:16:54.493] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:35:0)
[22:16:54.518] Build status: SCHEDULED
[22:16:54.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:36:0) after 8m44s
[22:25:38.674] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:36:0)
[22:25:38.818] Build status: SCHEDULED
[22:25:38.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:37:0) after 5m22s
[22:31:00.905] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:37:0)
[22:31:01.053] Build status: SCHEDULED
[22:31:01.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:38:0) after 1m6s
[22:32:07.100] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:38:0)
[22:32:07.141] Build status: SCHEDULED
[22:32:07.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:39:0) after 8m0s
[22:40:07.254] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:39:0)
[22:40:07.274] Build status: SCHEDULED
[22:40:07.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:40:0) after 8m33s
[22:48:41.981] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:40:0)
[22:48:42.021] Build status: SCHEDULED
[22:48:42.021] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:41:0) after 5m16s
[22:53:58.039] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:41:0)
[22:53:58.111] Build status: SCHEDULED
[22:53:58.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:42:0) after 7m3s
[23:01:01.413] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:42:0)
[23:01:01.446] Build status: SCHEDULED
[23:01:01.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:43:0) after 3m23s
[23:04:24.876] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:43:0)
[23:04:24.914] Build status: SCHEDULED
[23:04:24.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:44:0) after 2m44s
[23:07:08.936] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:44:0)
[23:07:08.959] Build status: SCHEDULED
[23:07:08.960] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:45:0) after 6m29s
[23:13:37.974] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:45:0)
[23:13:37.994] Build status: SCHEDULED
[23:13:37.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:46:0) after 7m31s
[23:21:09.022] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:46:0)
[23:21:09.057] Build status: SCHEDULED
[23:21:09.058] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:47:0) after 9m31s
[23:30:40.078] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:47:0)
[23:30:40.100] Build status: SCHEDULED
[23:30:40.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:48:0) after 9m40s
[23:40:20.258] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:48:0)
[23:40:20.286] Build status: SCHEDULED
[23:40:20.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:49:0) after 1m36s
[23:41:56.396] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:49:0)
[23:41:56.424] Build status: SCHEDULED
[23:41:56.424] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:50:0) after 8m54s
[23:50:50.507] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:50:0)
[23:50:50.524] Build status: SCHEDULED
[23:50:50.524] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:51:0) after 6m52s
[23:57:42.634] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:51:0)
[23:57:42.652] Build status: SCHEDULED
[23:57:42.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:52:0) after 3m35s
[00:01:17.899] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:52:0)
[00:01:17.929] Build status: SCHEDULED
[00:01:17.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:53:0) after 4m25s
[00:05:42.989] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:53:0)
[00:05:43.031] Build status: SCHEDULED
[00:05:43.031] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:54:0) after 8m42s
[00:14:25.048] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:54:0)
[00:14:25.071] Build status: SCHEDULED
[00:14:25.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:55:0) after 6m11s
[00:20:36.092] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:55:0)
[00:20:36.149] Build status: SCHEDULED
[00:20:36.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:56:0) after 8m56s
[00:29:32.167] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:56:0)
[00:29:32.188] Build status: SCHEDULED
[00:29:32.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:57:0) after 9m40s
[00:39:12.214] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:57:0)
[00:39:12.234] Build status: SCHEDULED
[00:39:12.234] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:58:0) after 3m35s
[00:42:47.259] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:58:0)
[00:42:47.281] Build status: SCHEDULED
[00:42:47.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:59:0) after 3m20s
[00:46:07.320] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:59:0)
[00:46:07.353] Build status: SCHEDULED
[00:46:07.353] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:60:0) after 2m43s
[00:48:50.586] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:60:0)
[00:48:50.611] Build status: SCHEDULED
[00:48:50.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:61:0) after 8m39s
[00:57:29.652] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:61:0)
[00:57:29.673] Build status: SCHEDULED
[00:57:29.673] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:62:0) after 2m26s
[00:59:55.872] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:62:0)
[00:59:55.897] Build status: SCHEDULED
[00:59:55.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:63:0) after 2m33s
[01:02:28.914] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:63:0)
[01:02:28.959] Build status: SCHEDULED
[01:02:28.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:64:0) after 2m47s
[01:05:16.024] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:64:0)
[01:05:16.045] Build status: SCHEDULED
[01:05:16.046] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:65:0) after 8m55s
[01:14:11.063] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:65:0)
[01:14:11.097] Build status: SCHEDULED
[01:14:11.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:66:0) after 6m45s
[01:20:56.118] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:66:0)
[01:20:56.145] Build status: SCHEDULED
[01:20:56.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:67:0) after 3m56s
[01:24:52.163] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:67:0)
[01:24:52.186] Build status: SCHEDULED
[01:24:52.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:68:0) after 6m40s
[01:31:32.405] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:68:0)
[01:31:32.429] Build status: SCHEDULED
[01:31:32.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:69:0) after 1m40s
[01:33:12.545] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:69:0)
[01:33:12.566] Build status: SCHEDULED
[01:33:12.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:70:0) after 3m32s
[01:36:44.599] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:70:0)
[01:36:44.649] Build status: SCHEDULED
[01:36:44.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:71:0) after 5m30s
[01:42:14.672] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:71:0)
[01:42:14.692] Build status: SCHEDULED
[01:42:14.692] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:72:0) after 2m51s
[01:45:05.708] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:72:0)
[01:45:05.732] Build status: SCHEDULED
[01:45:05.732] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:73:0) after 8m43s
[01:53:48.838] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:73:0)
[01:53:48.858] Build status: SCHEDULED
[01:53:48.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:74:0) after 1m17s
[01:55:05.873] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:74:0)
[01:55:05.966] Build status: SCHEDULED
[01:55:05.966] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:75:0) after 9m27s
[02:04:32.997] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:75:0)
[02:04:33.020] Build status: SCHEDULED
[02:04:33.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:76:0) after 6m37s
[02:11:10.037] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:76:0)
[02:11:10.070] Build status: SCHEDULED
[02:11:10.070] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:77:0) after 1m10s
[02:12:20.193] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:77:0)
[02:12:20.215] Build status: SCHEDULED
[02:12:20.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:78:0) after 6m34s
[02:18:54.303] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:78:0)
[02:18:54.323] Build status: SCHEDULED
[02:18:54.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:79:0) after 3m24s
[02:22:18.367] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:79:0)
[02:22:18.390] Build status: SCHEDULED
[02:22:18.390] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:80:0) after 2m22s
[02:24:40.410] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:80:0)
[02:24:40.428] Build status: SCHEDULED
[02:24:40.428] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:81:0) after 5m34s
[02:30:14.471] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:81:0)
[02:30:14.498] Build status: SCHEDULED
[02:30:14.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:82:0) after 8m5s
[02:38:19.514] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:82:0)
[02:38:19.537] Build status: SCHEDULED
[02:38:19.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:83:0) after 4m28s
[02:42:47.662] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:83:0)
[02:42:47.683] Build status: SCHEDULED
[02:42:47.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:84:0) after 6m52s
[02:49:39.817] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:84:0)
[02:49:39.848] Build status: SCHEDULED
[02:49:39.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:85:0) after 7m35s
[02:57:14.863] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:85:0)
[02:57:14.883] Build status: SCHEDULED
[02:57:14.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:86:0) after 9m8s
[03:06:22.968] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:86:0)
[03:06:22.990] Build status: SCHEDULED
[03:06:22.990] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:87:0) after 2m35s
[03:08:57.983] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:87:0)
[03:08:58.005] Build status: SCHEDULED
[03:08:58.005] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:88:0) after 3m25s
[03:12:23.039] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:88:0)
[03:12:23.062] Build status: SCHEDULED
[03:12:23.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:89:0) after 9m35s
[03:21:58.078] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:89:0)
[03:21:58.101] Build status: SCHEDULED
[03:21:58.101] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:90:0) after 9m47s
[03:31:45.122] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:90:0)
[03:31:45.158] Build status: SCHEDULED
[03:31:45.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:91:0) after 4m58s
[03:36:43.269] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:91:0)
[03:36:43.292] Build status: SCHEDULED
[03:36:43.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:92:0) after 9m44s
[03:46:27.309] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:92:0)
[03:46:27.338] Build status: SCHEDULED
[03:46:27.338] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:93:0) after 6m8s
[03:52:35.353] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:93:0)
[03:52:35.375] Build status: SCHEDULED
[03:52:35.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:94:0) after 2m18s
[03:54:53.478] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:94:0)
[03:54:53.504] Build status: SCHEDULED
[03:54:53.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:95:0) after 4m39s
[03:59:32.627] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:95:0)
[03:59:32.673] Build status: SCHEDULED
[03:59:32.673] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:96:0) after 4m47s
[04:04:19.694] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:96:0)
[04:04:19.714] Build status: SCHEDULED
[04:04:19.714] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:97:0) after 6m20s
[04:10:39.739] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:97:0)
[04:10:39.761] Build status: SCHEDULED
[04:10:39.761] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:98:0) after 6m14s
[04:16:53.916] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:98:0)
[04:16:53.949] Build status: SCHEDULED
[04:16:53.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:99:0) after 1m28s
[04:18:22.062] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:99:0)
[04:18:22.084] Build status: SCHEDULED
[04:18:22.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:100:0) after 9m21s
[04:27:43.266] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:100:0)
[04:27:43.284] Build status: SCHEDULED
[04:27:43.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:101:0) after 9m47s
[04:37:30.376] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:101:0)
[04:37:30.396] Build status: SCHEDULED
[04:37:30.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:102:0) after 6m47s
[04:44:17.432] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:102:0)
[04:44:17.454] Build status: SCHEDULED
[04:44:17.454] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:103:0) after 5m44s
[04:50:01.598] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:103:0)
[04:50:01.745] Build status: SCHEDULED
[04:50:01.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:104:0) after 8m9s
[04:58:10.759] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:104:0)
[04:58:11.030] Build status: SCHEDULED
[04:58:11.030] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:105:0) after 3m41s
[05:01:52.143] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:105:0)
[05:01:52.164] Build status: SCHEDULED
[05:01:52.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:106:0) after 5m20s
[05:07:12.244] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:106:0)
[05:07:12.268] Build status: SCHEDULED
[05:07:12.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:107:0) after 9m21s
[05:16:33.520] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:107:0)
[05:16:33.544] Build status: SCHEDULED
[05:16:33.544] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:108:0) after 4m5s
[05:20:38.573] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:108:0)
[05:20:38.597] Build status: SCHEDULED
[05:20:38.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:109:0) after 5m49s
[05:26:27.613] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:109:0)
[05:26:27.652] Build status: SCHEDULED
[05:26:27.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:110:0) after 3m12s
[05:29:39.637] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:110:0)
[05:29:39.721] Build status: SCHEDULED
[05:29:39.721] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:111:0) after 2m27s
[05:32:06.738] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:111:0)
[05:32:06.772] Build status: SCHEDULED
[05:32:06.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:112:0) after 8m39s
[05:40:45.803] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:112:0)
[05:40:45.824] Build status: SCHEDULED
[05:40:45.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:113:0) after 3m26s
[05:44:11.864] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:113:0)
[05:44:11.889] Build status: SCHEDULED
[05:44:11.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:114:0) after 7m15s
[05:51:27.055] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:114:0)
[05:51:27.152] Build status: SCHEDULED
[05:51:27.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:115:0) after 5m57s
[05:57:24.188] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:115:0)
[05:57:24.210] Build status: SCHEDULED
[05:57:24.210] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:116:0) after 4m3s
[06:01:27.385] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:116:0)
[06:01:27.409] Build status: SCHEDULED
[06:01:27.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:117:0) after 1m59s
[06:02:39.788] Received PubSub notification, asking Buildbucket for the build status
[06:02:39.839] Build status: STARTED
[06:03:26.525] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:117:0)
[06:03:26.547] Build status: STARTED
[06:03:26.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:119:0) after 3m26s
[06:06:52.859] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:119:0)
[06:06:52.883] Build status: STARTED
[06:06:52.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:120:0) after 4m59s
[06:11:51.900] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:120:0)
[06:11:51.919] Build status: STARTED
[06:11:51.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:121:0) after 6m3s
[06:17:55.047] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:121:0)
[06:17:55.098] Build status: STARTED
[06:17:55.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:122:0) after 7m31s
[06:25:26.173] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:122:0)
[06:25:26.196] Build status: STARTED
[06:25:26.196] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:123:0) after 3m37s
[06:29:03.217] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:123:0)
[06:29:03.245] Build status: STARTED
[06:29:03.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:124:0) after 2m21s
[06:31:24.271] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:124:0)
[06:31:24.290] Build status: STARTED
[06:31:24.290] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:125:0) after 9m21s
[06:40:45.356] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:125:0)
[06:40:45.433] Build status: STARTED
[06:40:45.433] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:126:0) after 4m29s
[06:45:14.453] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:126:0)
[06:45:14.488] Build status: STARTED
[06:45:14.488] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:127:0) after 9m31s
[06:54:45.505] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:127:0)
[06:54:45.526] Build status: STARTED
[06:54:45.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:128:0) after 3m39s
[06:58:24.587] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:128:0)
[06:58:24.611] Build status: STARTED
[06:58:24.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:129:0) after 2m46s
[07:01:10.627] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:129:0)
[07:01:10.727] Build status: STARTED
[07:01:10.727] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:130:0) after 1m32s
[07:02:42.749] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:130:0)
[07:02:42.804] Build status: STARTED
[07:02:42.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:131:0) after 5m0s
[07:07:42.823] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:131:0)
[07:07:42.846] Build status: STARTED
[07:07:42.846] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:132:0) after 1m20s
[07:09:02.865] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:132:0)
[07:09:02.954] Build status: STARTED
[07:09:02.955] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:133:0) after 5m17s
[07:14:20.070] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:133:0)
[07:14:20.093] Build status: STARTED
[07:14:20.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:134:0) after 7m23s
[07:21:43.249] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:134:0)
[07:21:43.270] Build status: STARTED
[07:21:43.270] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:135:0) after 3m2s
[07:24:45.338] Handling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:135:0)
[07:24:45.361] Build status: STARTED
[07:24:45.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-none_release:8954770011266875920:136:0) after 9m14s
[07:32:56.902] Received PubSub notification, asking Buildbucket for the build status
[07:32:56.940] Build:
{
"id": "8789339947071561473",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-none_release"
},
"number": 445,
"createdBy": "project:r8",
"createTime": "2023-02-12T19:14:16.522574813Z",
"startTime": "2023-02-13T06:02:38.107615Z",
"endTime": "2023-02-13T07:32:56.482401252Z",
"updateTime": "2023-02-13T07:32:56.482401252Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "5de6d7daaee1579dfe9f19b044cf3bc247e06050",
"ref": "refs/heads/8.1"
}
}
}
[07:32:56.940] Invocation finished in 12h18m43.802840277s with status SUCCEEDED