[17:28:38.277] New invocation is queued and will start shortly
[17:28:39.517] Starting the invocation (attempt 1)
[17:28:39.558] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/80e57b53298b99e9cae466c0e60e997d2d685dc8"
[17:28:39.558] Popped gitiles commit info from properties and tags
[17:28:39.558] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:28:39.560] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:28:39.561] Buildbucket request:
{
"requestId": "8976066940969239904",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8976066940969239904",
"job": "r8/linux-internal",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "9f274ce4def7781972ec09b6f40169af0eba8308"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@9f274ce4def7781972ec09b6f40169af0eba8308",
"title": "9f274ce4def7781972ec09b6f40169af0eba8308",
"url": "https://r8.googlesource.com/r8/+/9f274ce4def7781972ec09b6f40169af0eba8308"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "c9b242e04ee596ba15f3223b5b0c3a9bcd92f370"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@c9b242e04ee596ba15f3223b5b0c3a9bcd92f370",
"title": "c9b242e04ee596ba15f3223b5b0c3a9bcd92f370",
"url": "https://r8.googlesource.com/r8/+/c9b242e04ee596ba15f3223b5b0c3a9bcd92f370"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "114b9365b8932629ae277e032b33ef4c629f490e"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@114b9365b8932629ae277e032b33ef4c629f490e",
"title": "114b9365b8932629ae277e032b33ef4c629f490e",
"url": "https://r8.googlesource.com/r8/+/114b9365b8932629ae277e032b33ef4c629f490e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "929def9a60cc15112a2b390e2d700d0e5ab723b6"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@929def9a60cc15112a2b390e2d700d0e5ab723b6",
"title": "929def9a60cc15112a2b390e2d700d0e5ab723b6",
"url": "https://r8.googlesource.com/r8/+/929def9a60cc15112a2b390e2d700d0e5ab723b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "5d698843b302ee166a574ceb24724474d79ff924"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@5d698843b302ee166a574ceb24724474d79ff924",
"title": "5d698843b302ee166a574ceb24724474d79ff924",
"url": "https://r8.googlesource.com/r8/+/5d698843b302ee166a574ceb24724474d79ff924"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "01ddc4f12da3514851f8c48a5d5932568be05537"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@01ddc4f12da3514851f8c48a5d5932568be05537",
"title": "01ddc4f12da3514851f8c48a5d5932568be05537",
"url": "https://r8.googlesource.com/r8/+/01ddc4f12da3514851f8c48a5d5932568be05537"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "3ddb3f4b27d9686719cc7e68773c52348778a8a6"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@3ddb3f4b27d9686719cc7e68773c52348778a8a6",
"title": "3ddb3f4b27d9686719cc7e68773c52348778a8a6",
"url": "https://r8.googlesource.com/r8/+/3ddb3f4b27d9686719cc7e68773c52348778a8a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "a866fef498691f5193dc923a8965c8a6f6aded10"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@a866fef498691f5193dc923a8965c8a6f6aded10",
"title": "a866fef498691f5193dc923a8965c8a6f6aded10",
"url": "https://r8.googlesource.com/r8/+/a866fef498691f5193dc923a8965c8a6f6aded10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "260f96e41691c171f70fa64a4d701ebd4969be94"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@260f96e41691c171f70fa64a4d701ebd4969be94",
"title": "260f96e41691c171f70fa64a4d701ebd4969be94",
"url": "https://r8.googlesource.com/r8/+/260f96e41691c171f70fa64a4d701ebd4969be94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "6d5471478db03e9990a76c5f2f1b44bd2461e9b5"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@6d5471478db03e9990a76c5f2f1b44bd2461e9b5",
"title": "6d5471478db03e9990a76c5f2f1b44bd2461e9b5",
"url": "https://r8.googlesource.com/r8/+/6d5471478db03e9990a76c5f2f1b44bd2461e9b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "80e57b53298b99e9cae466c0e60e997d2d685dc8"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@80e57b53298b99e9cae466c0e60e997d2d685dc8",
"title": "80e57b53298b99e9cae466c0e60e997d2d685dc8",
"url": "https://r8.googlesource.com/r8/+/80e57b53298b99e9cae466c0e60e997d2d685dc8"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "80e57b53298b99e9cae466c0e60e997d2d685dc8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8976066940969239904"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-internal"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:28:40.103] Scheduled build:
{
"id": "8810636878874423953",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 2616,
"createdBy": "project:r8",
"createTime": "2022-06-22T17:28:39.643778012Z",
"updateTime": "2022-06-22T17:28:39.643778012Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "80e57b53298b99e9cae466c0e60e997d2d685dc8",
"ref": "refs/heads/main"
}
}
}
[17:28:40.104] Task URL: https://cr-buildbucket.appspot.com/build/8810636878874423953
[17:28:40.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:2:0) after 6m22s
[17:35:02.140] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:2:0)
[17:35:02.168] Build status: SCHEDULED
[17:35:02.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:3:0) after 6m1s
[17:41:03.561] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:3:0)
[17:41:03.595] Build status: SCHEDULED
[17:41:03.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:4:0) after 5m29s
[17:46:32.613] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:4:0)
[17:46:32.641] Build status: SCHEDULED
[17:46:32.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:5:0) after 3m4s
[17:49:36.852] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:5:0)
[17:49:36.875] Build status: SCHEDULED
[17:49:36.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:6:0) after 7m10s
[17:56:46.890] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:6:0)
[17:56:46.920] Build status: SCHEDULED
[17:56:46.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:7:0) after 9m48s
[18:06:35.040] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:7:0)
[18:06:35.083] Build status: SCHEDULED
[18:06:35.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:8:0) after 5m10s
[18:11:45.104] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:8:0)
[18:11:45.163] Build status: SCHEDULED
[18:11:45.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:9:0) after 1m21s
[18:13:06.175] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:9:0)
[18:13:06.213] Build status: SCHEDULED
[18:13:06.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:10:0) after 6m34s
[18:19:40.240] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:10:0)
[18:19:40.295] Build status: SCHEDULED
[18:19:40.295] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:11:0) after 1m23s
[18:21:03.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:11:0)
[18:21:03.354] Build status: SCHEDULED
[18:21:03.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:12:0) after 3m29s
[18:24:32.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:12:0)
[18:24:32.417] Build status: SCHEDULED
[18:24:32.417] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:13:0) after 8m51s
[18:33:23.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:13:0)
[18:33:23.482] Build status: SCHEDULED
[18:33:23.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:14:0) after 3m50s
[18:37:13.508] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:14:0)
[18:37:13.542] Build status: SCHEDULED
[18:37:13.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:15:0) after 4m31s
[18:41:44.571] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:15:0)
[18:41:44.618] Build status: SCHEDULED
[18:41:44.618] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:16:0) after 5m14s
[18:46:58.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:16:0)
[18:46:58.677] Build status: SCHEDULED
[18:46:58.677] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:17:0) after 8m44s
[18:55:42.701] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:17:0)
[18:55:42.735] Build status: SCHEDULED
[18:55:42.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:18:0) after 7m16s
[19:02:58.807] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:18:0)
[19:02:58.836] Build status: SCHEDULED
[19:02:58.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:19:0) after 7m2s
[19:10:01.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:19:0)
[19:10:01.584] Build status: SCHEDULED
[19:10:01.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:20:0) after 4m37s
[19:14:38.604] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:20:0)
[19:14:38.635] Build status: SCHEDULED
[19:14:38.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:21:0) after 6m43s
[19:21:21.675] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:21:0)
[19:21:21.719] Build status: SCHEDULED
[19:21:21.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:22:0) after 8m35s
[19:29:56.741] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:22:0)
[19:29:56.779] Build status: SCHEDULED
[19:29:56.779] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:23:0) after 9m55s
[19:39:51.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:23:0)
[19:39:51.893] Build status: SCHEDULED
[19:39:51.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:24:0) after 2m41s
[19:42:32.918] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:24:0)
[19:42:32.952] Build status: SCHEDULED
[19:42:32.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:25:0) after 2m4s
[19:44:36.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:25:0)
[19:44:37.019] Build status: SCHEDULED
[19:44:37.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:26:0) after 1m43s
[19:46:20.036] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:26:0)
[19:46:20.070] Build status: SCHEDULED
[19:46:20.070] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:27:0) after 3m11s
[19:49:31.387] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:27:0)
[19:49:31.421] Build status: SCHEDULED
[19:49:31.421] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:28:0) after 1m31s
[19:51:02.461] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:28:0)
[19:51:02.490] Build status: SCHEDULED
[19:51:02.490] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:29:0) after 7m6s
[19:58:09.458] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:29:0)
[19:58:09.490] Build status: SCHEDULED
[19:58:09.490] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:30:0) after 5m57s
[20:04:06.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:30:0)
[20:04:06.694] Build status: SCHEDULED
[20:04:06.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:31:0) after 1m34s
[20:05:40.790] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:31:0)
[20:05:40.830] Build status: SCHEDULED
[20:05:40.830] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:32:0) after 9m26s
[20:15:07.439] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:32:0)
[20:15:07.526] Build status: SCHEDULED
[20:15:07.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:33:0) after 7m25s
[20:22:32.614] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:33:0)
[20:22:32.678] Build status: SCHEDULED
[20:22:32.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:34:0) after 1m52s
[20:24:24.753] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:34:0)
[20:24:24.794] Build status: SCHEDULED
[20:24:24.794] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:35:0) after 8m56s
[20:33:20.944] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:35:0)
[20:33:20.975] Build status: SCHEDULED
[20:33:20.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:36:0) after 9m12s
[20:42:33.628] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:36:0)
[20:42:33.663] Build status: SCHEDULED
[20:42:33.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:37:0) after 6m34s
[20:49:07.842] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:37:0)
[20:49:07.875] Build status: SCHEDULED
[20:49:07.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:38:0) after 2m47s
[20:51:54.969] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:38:0)
[20:51:54.991] Build status: SCHEDULED
[20:51:54.991] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:39:0) after 3m13s
[20:55:08.088] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:39:0)
[20:55:08.116] Build status: SCHEDULED
[20:55:08.116] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:40:0) after 3m58s
[20:59:06.470] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:40:0)
[20:59:06.520] Build status: SCHEDULED
[20:59:06.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:41:0) after 5m24s
[21:04:30.564] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:41:0)
[21:04:30.698] Build status: SCHEDULED
[21:04:30.698] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:42:0) after 6m53s
[21:11:23.716] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:42:0)
[21:11:23.755] Build status: SCHEDULED
[21:11:23.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:43:0) after 3m33s
[21:14:56.886] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:43:0)
[21:14:56.920] Build status: SCHEDULED
[21:14:56.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:44:0) after 6m23s
[21:21:19.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:44:0)
[21:21:20.012] Build status: SCHEDULED
[21:21:20.012] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:45:0) after 3m57s
[21:25:17.134] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:45:0)
[21:25:17.168] Build status: SCHEDULED
[21:25:17.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:46:0) after 8m41s
[21:33:58.262] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:46:0)
[21:33:58.315] Build status: SCHEDULED
[21:33:58.315] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:47:0) after 4m54s
[21:38:52.336] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:47:0)
[21:38:52.452] Build status: SCHEDULED
[21:38:52.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:48:0) after 3m34s
[21:42:26.557] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:48:0)
[21:42:26.598] Build status: SCHEDULED
[21:42:26.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:49:0) after 1m0s
[21:43:26.647] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:49:0)
[21:43:26.680] Build status: SCHEDULED
[21:43:26.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:50:0) after 8m43s
[21:52:09.702] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:50:0)
[21:52:09.748] Build status: SCHEDULED
[21:52:09.748] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:51:0) after 4m19s
[21:56:28.808] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:51:0)
[21:56:28.887] Build status: SCHEDULED
[21:56:28.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:52:0) after 3m33s
[22:00:02.034] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:52:0)
[22:00:02.141] Build status: SCHEDULED
[22:00:02.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:53:0) after 3m46s
[22:03:48.161] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:53:0)
[22:03:48.200] Build status: SCHEDULED
[22:03:48.200] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:54:0) after 2m34s
[22:06:22.220] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:54:0)
[22:06:22.253] Build status: SCHEDULED
[22:06:22.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:55:0) after 3m42s
[22:10:04.273] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:55:0)
[22:10:04.306] Build status: SCHEDULED
[22:10:04.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:56:0) after 2m0s
[22:12:04.330] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:56:0)
[22:12:04.367] Build status: SCHEDULED
[22:12:04.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:57:0) after 9m56s
[22:22:00.565] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:57:0)
[22:22:00.595] Build status: SCHEDULED
[22:22:00.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:58:0) after 1m33s
[22:23:33.980] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:58:0)
[22:23:34.028] Build status: SCHEDULED
[22:23:34.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:59:0) after 6m47s
[22:27:14.787] Received PubSub notification, asking Buildbucket for the build status
[22:27:14.831] Build status: STARTED
[22:30:21.048] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:59:0)
[22:30:21.081] Build status: STARTED
[22:30:21.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:61:0) after 4m14s
[22:34:35.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:61:0)
[22:34:35.222] Build status: STARTED
[22:34:35.222] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:62:0) after 6m49s
[22:41:24.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:62:0)
[22:41:24.285] Build status: STARTED
[22:41:24.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:63:0) after 8m44s
[22:50:08.305] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:63:0)
[22:50:08.340] Build status: STARTED
[22:50:08.340] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:64:0) after 9m29s
[22:59:37.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:64:0)
[22:59:37.852] Build status: STARTED
[22:59:37.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:65:0) after 8m57s
[23:08:35.016] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:65:0)
[23:08:35.057] Build status: STARTED
[23:08:35.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:66:0) after 8m14s
[23:16:49.080] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:66:0)
[23:16:49.115] Build status: STARTED
[23:16:49.115] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:67:0) after 8m54s
[23:25:43.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:67:0)
[23:25:43.457] Build status: STARTED
[23:25:43.457] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:68:0) after 3m17s
[23:29:01.328] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:68:0)
[23:29:01.370] Build status: STARTED
[23:29:01.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:69:0) after 7m51s
[23:36:52.939] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:69:0)
[23:36:52.972] Build status: STARTED
[23:36:52.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:70:0) after 5m27s
[23:42:19.992] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:70:0)
[23:42:20.059] Build status: STARTED
[23:42:20.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:71:0) after 2m7s
[23:44:27.095] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:71:0)
[23:44:27.129] Build status: STARTED
[23:44:27.129] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:72:0) after 2m19s
[23:46:46.240] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:72:0)
[23:46:46.281] Build status: STARTED
[23:46:46.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:73:0) after 7m6s
[23:53:52.354] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:73:0)
[23:53:52.412] Build status: STARTED
[23:53:52.412] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:74:0) after 9m21s
[00:03:13.533] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:74:0)
[00:03:13.598] Build status: STARTED
[00:03:13.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:75:0) after 3m3s
[00:06:16.617] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:75:0)
[00:06:16.676] Build status: STARTED
[00:06:16.676] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:76:0) after 5m41s
[00:11:57.758] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:76:0)
[00:11:57.790] Build status: STARTED
[00:11:57.790] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:77:0) after 6m44s
[00:18:42.182] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:77:0)
[00:18:42.220] Build status: STARTED
[00:18:42.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:78:0) after 1m19s
[00:20:02.016] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:78:0)
[00:20:02.065] Build status: STARTED
[00:20:02.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:79:0) after 5m7s
[00:25:09.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:79:0)
[00:25:09.707] Build status: STARTED
[00:25:09.707] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:80:0) after 9m18s
[00:34:27.829] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:80:0)
[00:34:27.865] Build status: STARTED
[00:34:27.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:81:0) after 3m39s
[00:38:06.888] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:81:0)
[00:38:06.928] Build status: STARTED
[00:38:06.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:82:0) after 6m49s
[00:44:56.007] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:82:0)
[00:44:56.076] Build status: STARTED
[00:44:56.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:83:0) after 3m7s
[00:48:03.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:83:0)
[00:48:03.147] Build status: STARTED
[00:48:03.147] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:84:0) after 1m2s
[00:49:05.168] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:84:0)
[00:49:05.205] Build status: STARTED
[00:49:05.205] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:85:0) after 2m51s
[00:51:56.403] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:85:0)
[00:51:56.436] Build status: STARTED
[00:51:56.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:86:0) after 3m53s
[00:55:49.457] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:86:0)
[00:55:49.509] Build status: STARTED
[00:55:49.509] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:87:0) after 9m2s
[01:04:51.562] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:87:0)
[01:04:51.597] Build status: STARTED
[01:04:51.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:88:0) after 4m6s
[01:08:57.745] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:88:0)
[01:08:57.781] Build status: STARTED
[01:08:57.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:89:0) after 2m38s
[01:11:35.929] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:89:0)
[01:11:35.970] Build status: STARTED
[01:11:35.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:90:0) after 9m32s
[01:21:07.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:90:0)
[01:21:08.027] Build status: STARTED
[01:21:08.027] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:91:0) after 7m0s
[01:28:08.085] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:91:0)
[01:28:08.122] Build status: STARTED
[01:28:08.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:92:0) after 9m28s
[01:37:36.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:92:0)
[01:37:36.172] Build status: STARTED
[01:37:36.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:93:0) after 9m16s
[01:46:52.282] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:93:0)
[01:46:52.317] Build status: STARTED
[01:46:52.317] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:94:0) after 6m6s
[01:52:58.458] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:94:0)
[01:52:58.489] Build status: STARTED
[01:52:58.489] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:95:0) after 6m3s
[01:59:02.093] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:95:0)
[01:59:02.128] Build status: STARTED
[01:59:02.128] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:96:0) after 3m0s
[02:02:02.378] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:96:0)
[02:02:02.415] Build status: STARTED
[02:02:02.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:97:0) after 1m26s
[02:03:28.663] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:97:0)
[02:03:28.695] Build status: STARTED
[02:03:28.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:98:0) after 4m37s
[02:08:07.145] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:98:0)
[02:08:07.178] Build status: STARTED
[02:08:07.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:99:0) after 2m14s
[02:10:21.228] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:99:0)
[02:10:21.282] Build status: STARTED
[02:10:21.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:100:0) after 1m3s
[02:11:24.426] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:100:0)
[02:11:24.468] Build status: STARTED
[02:11:24.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:101:0) after 2m4s
[02:13:28.588] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:101:0)
[02:13:28.619] Build status: STARTED
[02:13:28.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:102:0) after 6m53s
[02:20:21.644] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:102:0)
[02:20:21.684] Build status: STARTED
[02:20:21.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:103:0) after 4m41s
[02:25:02.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:103:0)
[02:25:02.991] Build status: STARTED
[02:25:02.991] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:104:0) after 2m51s
[02:27:54.086] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:104:0)
[02:27:54.114] Build status: STARTED
[02:27:54.114] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:105:0) after 1m50s
[02:29:44.285] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:105:0)
[02:29:44.319] Build status: STARTED
[02:29:44.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:106:0) after 7m41s
[02:37:25.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:106:0)
[02:37:25.375] Build status: STARTED
[02:37:25.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:107:0) after 4m58s
[02:42:23.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:107:0)
[02:42:23.713] Build status: STARTED
[02:42:23.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:108:0) after 9m1s
[02:51:24.958] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:108:0)
[02:51:24.989] Build status: STARTED
[02:51:24.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:109:0) after 7m28s
[02:58:53.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:109:0)
[02:58:53.136] Build status: STARTED
[02:58:53.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:110:0) after 1m40s
[03:00:33.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:110:0)
[03:00:33.343] Build status: STARTED
[03:00:33.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:111:0) after 5m54s
[03:06:27.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:111:0)
[03:06:27.701] Build status: STARTED
[03:06:27.701] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:112:0) after 6m7s
[03:12:34.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:112:0)
[03:12:34.804] Build status: STARTED
[03:12:34.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:113:0) after 4m7s
[03:16:41.873] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:113:0)
[03:16:41.908] Build status: STARTED
[03:16:41.908] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:114:0) after 6m56s
[03:23:37.936] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:114:0)
[03:23:37.989] Build status: STARTED
[03:23:37.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:115:0) after 6m9s
[03:29:46.993] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:115:0)
[03:29:47.025] Build status: STARTED
[03:29:47.025] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:116:0) after 7m51s
[03:37:38.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:116:0)
[03:37:38.170] Build status: STARTED
[03:37:38.170] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:117:0) after 4m53s
[03:42:31.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:117:0)
[03:42:31.231] Build status: STARTED
[03:42:31.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:118:0) after 7m8s
[03:49:39.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:118:0)
[03:49:39.370] Build status: STARTED
[03:49:39.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:119:0) after 8m15s
[03:57:54.474] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:119:0)
[03:57:54.544] Build status: STARTED
[03:57:54.544] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:120:0) after 5m51s
[04:03:45.592] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:120:0)
[04:03:45.638] Build status: STARTED
[04:03:45.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:121:0) after 2m11s
[04:05:56.788] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:121:0)
[04:05:56.809] Build status: STARTED
[04:05:56.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:122:0) after 4m40s
[04:10:36.969] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:122:0)
[04:10:37.006] Build status: STARTED
[04:10:37.006] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:123:0) after 5m7s
[04:15:44.038] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:123:0)
[04:15:44.072] Build status: STARTED
[04:15:44.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:124:0) after 8m9s
[04:23:53.068] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:124:0)
[04:23:53.105] Build status: STARTED
[04:23:53.105] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:125:0) after 4m28s
[04:28:21.170] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:125:0)
[04:28:21.203] Build status: STARTED
[04:28:21.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:126:0) after 3m28s
[04:31:49.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:126:0)
[04:31:49.267] Build status: STARTED
[04:31:49.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:127:0) after 6m39s
[04:38:28.375] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:127:0)
[04:38:28.422] Build status: STARTED
[04:38:28.422] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:128:0) after 8m40s
[04:47:08.537] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:128:0)
[04:47:08.655] Build status: STARTED
[04:47:08.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:129:0) after 9m45s
[04:56:53.717] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:129:0)
[04:56:53.753] Build status: STARTED
[04:56:53.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:130:0) after 2m16s
[04:59:09.799] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:130:0)
[04:59:09.831] Build status: STARTED
[04:59:09.831] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:131:0) after 8m38s
[05:07:48.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:131:0)
[05:07:48.248] Build status: STARTED
[05:07:48.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:132:0) after 5m25s
[05:13:13.350] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:132:0)
[05:13:13.381] Build status: STARTED
[05:13:13.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:133:0) after 9m25s
[05:22:38.909] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:133:0)
[05:22:38.939] Build status: STARTED
[05:22:38.939] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:134:0) after 6m46s
[05:29:24.962] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:134:0)
[05:29:24.998] Build status: STARTED
[05:29:24.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:135:0) after 9m44s
[05:39:09.021] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:135:0)
[05:39:09.061] Build status: STARTED
[05:39:09.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:136:0) after 1m35s
[05:40:44.131] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:136:0)
[05:40:44.185] Build status: STARTED
[05:40:44.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:137:0) after 7m8s
[05:47:52.219] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:137:0)
[05:47:52.253] Build status: STARTED
[05:47:52.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:138:0) after 1m2s
[05:48:54.367] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:138:0)
[05:48:54.429] Build status: STARTED
[05:48:54.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:139:0) after 7m49s
[05:56:43.507] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:139:0)
[05:56:43.530] Build status: STARTED
[05:56:43.530] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:140:0) after 6m51s
[06:03:34.550] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:140:0)
[06:03:34.586] Build status: STARTED
[06:03:34.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:141:0) after 6m47s
[06:10:21.699] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:141:0)
[06:10:21.724] Build status: STARTED
[06:10:21.724] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:142:0) after 1m3s
[06:11:24.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:142:0)
[06:11:24.801] Build status: STARTED
[06:11:24.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:143:0) after 1m41s
[06:13:05.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:143:0)
[06:13:06.033] Build status: STARTED
[06:13:06.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:144:0) after 6m25s
[06:19:31.076] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:144:0)
[06:19:31.176] Build status: STARTED
[06:19:31.176] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:145:0) after 6m24s
[06:25:55.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:145:0)
[06:25:55.285] Build status: STARTED
[06:25:55.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:146:0) after 1m6s
[06:27:01.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:146:0)
[06:27:01.341] Build status: STARTED
[06:27:01.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:147:0) after 1m16s
[06:28:17.362] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:147:0)
[06:28:17.395] Build status: STARTED
[06:28:17.395] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:148:0) after 1m33s
[06:29:50.413] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:148:0)
[06:29:50.462] Build status: STARTED
[06:29:50.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:149:0) after 8m23s
[06:38:13.497] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:149:0)
[06:38:13.531] Build status: STARTED
[06:38:13.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:150:0) after 2m32s
[06:40:45.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:150:0)
[06:40:45.592] Build status: STARTED
[06:40:45.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:151:0) after 5m25s
[06:46:10.616] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:151:0)
[06:46:10.647] Build status: STARTED
[06:46:10.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:152:0) after 2m5s
[06:48:15.834] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:152:0)
[06:48:15.877] Build status: STARTED
[06:48:15.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:153:0) after 9m35s
[06:57:51.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:153:0)
[06:57:51.264] Build status: STARTED
[06:57:51.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:154:0) after 9m14s
[07:07:05.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:154:0)
[07:07:05.423] Build status: STARTED
[07:07:05.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:155:0) after 7m26s
[07:14:31.558] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:155:0)
[07:14:31.615] Build status: STARTED
[07:14:31.615] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:156:0) after 7m17s
[07:21:48.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:156:0)
[07:21:48.711] Build status: STARTED
[07:21:48.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:157:0) after 1m22s
[07:23:11.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:157:0)
[07:23:11.108] Build status: STARTED
[07:23:11.108] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:158:0) after 3m20s
[07:26:31.234] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:158:0)
[07:26:31.279] Build status: STARTED
[07:26:31.279] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:159:0) after 5m6s
[07:31:37.506] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:159:0)
[07:31:37.538] Build status: STARTED
[07:31:37.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:160:0) after 6m48s
[07:38:25.558] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:160:0)
[07:38:25.593] Build status: STARTED
[07:38:25.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:161:0) after 6m13s
[07:44:38.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:161:0)
[07:44:38.864] Build status: STARTED
[07:44:38.864] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:162:0) after 6m7s
[07:50:46.055] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:162:0)
[07:50:46.079] Build status: STARTED
[07:50:46.079] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:163:0) after 1m12s
[07:51:58.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:163:0)
[07:51:58.310] Build status: STARTED
[07:51:58.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:164:0) after 2m35s
[07:54:33.532] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:164:0)
[07:54:33.579] Build status: STARTED
[07:54:33.579] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:165:0) after 9m11s
[08:03:44.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:165:0)
[08:03:44.622] Build status: STARTED
[08:03:44.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:166:0) after 1m6s
[08:04:50.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:166:0)
[08:04:50.685] Build status: STARTED
[08:04:50.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:167:0) after 5m55s
[08:10:45.722] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:167:0)
[08:10:45.771] Build status: STARTED
[08:10:45.771] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8976066940969239904:168:0) after 8m31s
[08:13:58.523] Received PubSub notification, asking Buildbucket for the build status
[08:13:58.557] Build:
{
"id": "8810636878874423953",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 2616,
"createdBy": "project:r8",
"createTime": "2022-06-22T17:28:39.643778012Z",
"startTime": "2022-06-22T22:27:13.577779Z",
"endTime": "2022-06-23T08:13:17.028254983Z",
"updateTime": "2022-06-23T08:13:17.028254983Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "80e57b53298b99e9cae466c0e60e997d2d685dc8",
"ref": "refs/heads/main"
}
}
}
[08:13:58.557] Invocation finished in 14h45m20.295339014s with status FAILED