[18:50:04.346] New invocation is queued and will start shortly
[18:50:05.526] Starting the invocation (attempt 1)
[18:50:05.563] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/0b9733dac11480b5a37a97eca7fa434c84418a83"
[18:50:05.563] Popped gitiles commit info from properties and tags
[18:50:05.563] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:50:05.563] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:50:05.563] Buildbucket request:
{
"requestId": "8981135247673075696",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8981135247673075696",
"job": "r8/linux-internal_release",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/3.3",
"repo": "https://r8.googlesource.com/r8",
"revision": "0b9733dac11480b5a37a97eca7fa434c84418a83"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/3.3@0b9733dac11480b5a37a97eca7fa434c84418a83",
"title": "0b9733dac11480b5a37a97eca7fa434c84418a83",
"url": "https://r8.googlesource.com/r8/+/0b9733dac11480b5a37a97eca7fa434c84418a83"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "0b9733dac11480b5a37a97eca7fa434c84418a83",
"ref": "refs/heads/3.3"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8981135247673075696"
},
{
"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"
}
}
[18:50:06.143] Scheduled build:
{
"id": "8815705185621454577",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 623,
"createdBy": "project:r8",
"createTime": "2022-04-27T18:50:05.671751422Z",
"updateTime": "2022-04-27T18:50:05.671751422Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "0b9733dac11480b5a37a97eca7fa434c84418a83",
"ref": "refs/heads/3.3"
}
}
}
[18:50:06.143] Task URL: https://cr-buildbucket.appspot.com/build/8815705185621454577
[18:50:06.143] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:2:0) after 9m5s
[18:59:11.445] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:2:0)
[18:59:11.480] Build status: SCHEDULED
[18:59:11.480] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:3:0) after 9m25s
[19:08:36.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:3:0)
[19:08:36.528] Build status: SCHEDULED
[19:08:36.528] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:4:0) after 5m53s
[19:14:29.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:4:0)
[19:14:29.577] Build status: SCHEDULED
[19:14:29.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:5:0) after 4m55s
[19:19:24.592] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:5:0)
[19:19:24.624] Build status: SCHEDULED
[19:19:24.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:6:0) after 6m35s
[19:25:59.657] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:6:0)
[19:25:59.684] Build status: SCHEDULED
[19:25:59.684] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:7:0) after 2m22s
[19:28:21.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:7:0)
[19:28:21.805] Build status: SCHEDULED
[19:28:21.805] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:8:0) after 8m48s
[19:37:09.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:8:0)
[19:37:09.949] Build status: SCHEDULED
[19:37:09.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:9:0) after 8m31s
[19:45:40.964] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:9:0)
[19:45:40.998] Build status: SCHEDULED
[19:45:40.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:10:0) after 1m33s
[19:47:14.017] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:10:0)
[19:47:14.052] Build status: SCHEDULED
[19:47:14.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:11:0) after 4m54s
[19:52:08.049] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:11:0)
[19:52:08.080] Build status: SCHEDULED
[19:52:08.080] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:12:0) after 8m2s
[20:00:10.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:12:0)
[20:00:10.394] Build status: SCHEDULED
[20:00:10.394] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:13:0) after 8m20s
[20:08:30.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:13:0)
[20:08:30.450] Build status: SCHEDULED
[20:08:30.450] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:14:0) after 3m33s
[20:12:03.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:14:0)
[20:12:03.520] Build status: SCHEDULED
[20:12:03.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:15:0) after 1m58s
[20:14:01.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:15:0)
[20:14:01.576] Build status: SCHEDULED
[20:14:01.576] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:16:0) after 7m18s
[20:21:19.640] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:16:0)
[20:21:19.670] Build status: SCHEDULED
[20:21:19.670] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:17:0) after 6m33s
[20:27:52.713] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:17:0)
[20:27:52.862] Build status: SCHEDULED
[20:27:52.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:18:0) after 4m22s
[20:32:14.854] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:18:0)
[20:32:14.883] Build status: SCHEDULED
[20:32:14.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:19:0) after 6m12s
[20:38:26.904] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:19:0)
[20:38:26.932] Build status: SCHEDULED
[20:38:26.932] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:20:0) after 3m34s
[20:42:01.016] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:20:0)
[20:42:01.041] Build status: SCHEDULED
[20:42:01.041] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:21:0) after 4m18s
[20:46:19.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:21:0)
[20:46:19.186] Build status: SCHEDULED
[20:46:19.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:22:0) after 1m33s
[20:47:52.200] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:22:0)
[20:47:52.261] Build status: SCHEDULED
[20:47:52.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:23:0) after 1m6s
[20:48:58.351] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:23:0)
[20:48:58.442] Build status: SCHEDULED
[20:48:58.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:24:0) after 7m8s
[20:56:06.465] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:24:0)
[20:56:06.495] Build status: SCHEDULED
[20:56:06.495] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:25:0) after 8m20s
[21:04:26.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:25:0)
[21:04:26.563] Build status: SCHEDULED
[21:04:26.563] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:26:0) after 7m5s
[21:11:31.580] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:26:0)
[21:11:31.664] Build status: SCHEDULED
[21:11:31.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:27:0) after 8m26s
[21:19:57.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:27:0)
[21:19:57.895] Build status: SCHEDULED
[21:19:57.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:28:0) after 3m12s
[21:23:09.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:28:0)
[21:23:09.998] Build status: SCHEDULED
[21:23:09.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:29:0) after 9m5s
[21:32:15.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:29:0)
[21:32:15.099] Build status: SCHEDULED
[21:32:15.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:30:0) after 7m42s
[21:39:57.173] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:30:0)
[21:39:57.282] Build status: SCHEDULED
[21:39:57.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:31:0) after 6m50s
[21:46:48.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:31:0)
[21:46:48.543] Build status: SCHEDULED
[21:46:48.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:32:0) after 8m15s
[21:55:04.038] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:32:0)
[21:55:04.077] Build status: SCHEDULED
[21:55:04.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:33:0) after 4m38s
[21:59:42.111] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:33:0)
[21:59:42.148] Build status: SCHEDULED
[21:59:42.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:34:0) after 2m0s
[22:01:42.184] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:34:0)
[22:01:42.216] Build status: SCHEDULED
[22:01:42.216] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:35:0) after 2m38s
[22:04:20.197] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:35:0)
[22:04:20.226] Build status: SCHEDULED
[22:04:20.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:36:0) after 8m31s
[22:05:58.001] Received PubSub notification, asking Buildbucket for the build status
[22:05:58.037] Build status: STARTED
[22:12:51.345] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:36:0)
[22:12:51.376] Build status: STARTED
[22:12:51.376] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:38:0) after 5m43s
[22:18:34.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:38:0)
[22:18:34.455] Build status: STARTED
[22:18:34.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:39:0) after 2m41s
[22:21:16.198] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:39:0)
[22:21:16.311] Build status: STARTED
[22:21:16.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:40:0) after 9m33s
[22:30:49.699] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:40:0)
[22:30:49.745] Build status: STARTED
[22:30:49.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:41:0) after 3m13s
[22:34:02.790] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:41:0)
[22:34:02.837] Build status: STARTED
[22:34:02.837] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:42:0) after 4m33s
[22:38:35.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:42:0)
[22:38:35.887] Build status: STARTED
[22:38:35.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:43:0) after 2m26s
[22:41:02.189] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:43:0)
[22:41:02.228] Build status: STARTED
[22:41:02.228] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:44:0) after 6m46s
[22:47:48.623] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:44:0)
[22:47:48.681] Build status: STARTED
[22:47:48.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:45:0) after 9m48s
[22:57:36.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:45:0)
[22:57:36.832] Build status: STARTED
[22:57:36.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:46:0) after 7m18s
[23:04:54.903] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:46:0)
[23:04:54.942] Build status: STARTED
[23:04:54.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:47:0) after 2m44s
[23:07:39.095] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:47:0)
[23:07:39.204] Build status: STARTED
[23:07:39.204] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:48:0) after 1m11s
[23:08:50.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:48:0)
[23:08:50.281] Build status: STARTED
[23:08:50.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:49:0) after 2m3s
[23:10:53.577] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:49:0)
[23:10:53.609] Build status: STARTED
[23:10:53.609] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:50:0) after 9m24s
[23:20:17.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:50:0)
[23:20:17.708] Build status: STARTED
[23:20:17.708] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:51:0) after 9m40s
[23:29:57.725] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:51:0)
[23:29:57.755] Build status: STARTED
[23:29:57.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:52:0) after 5m40s
[23:35:37.961] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:52:0)
[23:35:38.019] Build status: STARTED
[23:35:38.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:53:0) after 1m24s
[23:37:02.266] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:53:0)
[23:37:02.299] Build status: STARTED
[23:37:02.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:54:0) after 9m26s
[23:46:28.383] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:54:0)
[23:46:28.451] Build status: STARTED
[23:46:28.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:55:0) after 8m45s
[23:55:13.475] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:55:0)
[23:55:13.597] Build status: STARTED
[23:55:13.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:56:0) after 3m14s
[23:58:27.899] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:56:0)
[23:58:27.933] Build status: STARTED
[23:58:27.933] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:57:0) after 8m23s
[00:06:51.288] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:57:0)
[00:06:51.314] Build status: STARTED
[00:06:51.314] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:58:0) after 4m16s
[00:11:07.361] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:58:0)
[00:11:07.406] Build status: STARTED
[00:11:07.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:59:0) after 3m37s
[00:14:44.398] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:59:0)
[00:14:44.459] Build status: STARTED
[00:14:44.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:60:0) after 6m42s
[00:21:26.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:60:0)
[00:21:26.521] Build status: STARTED
[00:21:26.521] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:61:0) after 9m41s
[00:31:07.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:61:0)
[00:31:07.675] Build status: STARTED
[00:31:07.675] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:62:0) after 4m6s
[00:35:13.692] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:62:0)
[00:35:13.757] Build status: STARTED
[00:35:13.757] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:63:0) after 5m9s
[00:40:22.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:63:0)
[00:40:23.025] Build status: STARTED
[00:40:23.025] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:64:0) after 6m33s
[00:46:56.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:64:0)
[00:46:56.172] Build status: STARTED
[00:46:56.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:65:0) after 3m3s
[00:49:59.194] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:65:0)
[00:49:59.225] Build status: STARTED
[00:49:59.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:66:0) after 1m50s
[00:51:49.261] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:66:0)
[00:51:49.360] Build status: STARTED
[00:51:49.360] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:67:0) after 8m4s
[00:59:53.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:67:0)
[00:59:53.487] Build status: STARTED
[00:59:53.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:68:0) after 4m44s
[01:04:37.508] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:68:0)
[01:04:37.544] Build status: STARTED
[01:04:37.544] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:69:0) after 4m2s
[01:08:39.564] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:69:0)
[01:08:39.591] Build status: STARTED
[01:08:39.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:70:0) after 7m40s
[01:16:19.955] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:70:0)
[01:16:19.984] Build status: STARTED
[01:16:19.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:71:0) after 7m38s
[01:23:58.015] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:71:0)
[01:23:58.074] Build status: STARTED
[01:23:58.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:72:0) after 9m41s
[01:33:39.366] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:72:0)
[01:33:39.394] Build status: STARTED
[01:33:39.394] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:73:0) after 6m20s
[01:39:59.415] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:73:0)
[01:39:59.449] Build status: STARTED
[01:39:59.449] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:74:0) after 4m17s
[01:44:16.476] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:74:0)
[01:44:16.511] Build status: STARTED
[01:44:16.511] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:75:0) after 2m32s
[01:46:48.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:75:0)
[01:46:48.572] Build status: STARTED
[01:46:48.572] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:76:0) after 6m23s
[01:53:11.667] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:76:0)
[01:53:11.710] Build status: STARTED
[01:53:11.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:77:0) after 1m36s
[01:54:47.731] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:77:0)
[01:54:47.763] Build status: STARTED
[01:54:47.763] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:78:0) after 3m50s
[01:58:37.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:78:0)
[01:58:37.892] Build status: STARTED
[01:58:37.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:79:0) after 5m21s
[02:03:59.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:79:0)
[02:03:59.138] Build status: STARTED
[02:03:59.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:80:0) after 4m54s
[02:08:53.161] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:80:0)
[02:08:53.192] Build status: STARTED
[02:08:53.192] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:81:0) after 6m8s
[02:15:01.456] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:81:0)
[02:15:01.497] Build status: STARTED
[02:15:01.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:82:0) after 4m29s
[02:19:30.604] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:82:0)
[02:19:30.650] Build status: STARTED
[02:19:30.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:83:0) after 7m44s
[02:27:15.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:83:0)
[02:27:15.191] Build status: STARTED
[02:27:15.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:84:0) after 5m46s
[02:33:01.427] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:84:0)
[02:33:01.460] Build status: STARTED
[02:33:01.460] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:85:0) after 8m33s
[02:41:34.874] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:85:0)
[02:41:34.898] Build status: STARTED
[02:41:34.898] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:86:0) after 7m39s
[02:49:14.010] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:86:0)
[02:49:14.044] Build status: STARTED
[02:49:14.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:87:0) after 3m43s
[02:52:57.173] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:87:0)
[02:52:57.209] Build status: STARTED
[02:52:57.209] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:88:0) after 2m48s
[02:55:45.258] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:88:0)
[02:55:45.293] Build status: STARTED
[02:55:45.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8981135247673075696:89:0) after 7m33s
[02:57:56.694] Received PubSub notification, asking Buildbucket for the build status
[02:57:56.759] Build:
{
"id": "8815705185621454577",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 623,
"createdBy": "project:r8",
"createTime": "2022-04-27T18:50:05.671751422Z",
"startTime": "2022-04-27T22:05:57.025337Z",
"endTime": "2022-04-28T02:57:56.231948197Z",
"updateTime": "2022-04-28T02:57:56.231948197Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "0b9733dac11480b5a37a97eca7fa434c84418a83",
"ref": "refs/heads/3.3"
}
}
}
[02:57:56.759] Invocation finished in 8h7m52.427393826s with status SUCCEEDED