[14:36:09.520] New invocation is queued and will start shortly
[14:36:10.659] Starting the invocation (attempt 1)
[14:36:10.688] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/cfacf1e9f428d6853195cfb041ef5fda997662eb"
[14:36:10.688] Popped gitiles commit info from properties and tags
[14:36:10.688] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:36:10.688] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:36:10.690] Buildbucket request:
{
"requestId": "8955059296218175488",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8955059296218175488",
"job": "r8/linux-internal",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "978b53bbe0ed5d32a65fed0282a5b9377eb3ab6a"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@978b53bbe0ed5d32a65fed0282a5b9377eb3ab6a",
"title": "978b53bbe0ed5d32a65fed0282a5b9377eb3ab6a",
"url": "https://r8.googlesource.com/r8/+/978b53bbe0ed5d32a65fed0282a5b9377eb3ab6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "afb171258fefe92052008b8b2a695e0f78266098"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@afb171258fefe92052008b8b2a695e0f78266098",
"title": "afb171258fefe92052008b8b2a695e0f78266098",
"url": "https://r8.googlesource.com/r8/+/afb171258fefe92052008b8b2a695e0f78266098"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "070dbc6600ec941ba269178c90fc51218d7248b0"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@070dbc6600ec941ba269178c90fc51218d7248b0",
"title": "070dbc6600ec941ba269178c90fc51218d7248b0",
"url": "https://r8.googlesource.com/r8/+/070dbc6600ec941ba269178c90fc51218d7248b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "094e32b099cc21b56d10fee7dc7145e7e0462d80"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@094e32b099cc21b56d10fee7dc7145e7e0462d80",
"title": "094e32b099cc21b56d10fee7dc7145e7e0462d80",
"url": "https://r8.googlesource.com/r8/+/094e32b099cc21b56d10fee7dc7145e7e0462d80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "75caac36ba292e4a633dfededffde3368e1c0c82"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@75caac36ba292e4a633dfededffde3368e1c0c82",
"title": "75caac36ba292e4a633dfededffde3368e1c0c82",
"url": "https://r8.googlesource.com/r8/+/75caac36ba292e4a633dfededffde3368e1c0c82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "54ed0312d2e5ade4b8092a86989d0e6827e646dd"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@54ed0312d2e5ade4b8092a86989d0e6827e646dd",
"title": "54ed0312d2e5ade4b8092a86989d0e6827e646dd",
"url": "https://r8.googlesource.com/r8/+/54ed0312d2e5ade4b8092a86989d0e6827e646dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "aaad1e9457ccc797f68e3603e923a40a8314ef6b"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@aaad1e9457ccc797f68e3603e923a40a8314ef6b",
"title": "aaad1e9457ccc797f68e3603e923a40a8314ef6b",
"url": "https://r8.googlesource.com/r8/+/aaad1e9457ccc797f68e3603e923a40a8314ef6b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "1945e8f7e35acf175184f4578cc056681b936914"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@1945e8f7e35acf175184f4578cc056681b936914",
"title": "1945e8f7e35acf175184f4578cc056681b936914",
"url": "https://r8.googlesource.com/r8/+/1945e8f7e35acf175184f4578cc056681b936914"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "0a96694ef84bf36c2374d9408929a93683166959"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@0a96694ef84bf36c2374d9408929a93683166959",
"title": "0a96694ef84bf36c2374d9408929a93683166959",
"url": "https://r8.googlesource.com/r8/+/0a96694ef84bf36c2374d9408929a93683166959"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "cfacf1e9f428d6853195cfb041ef5fda997662eb"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@cfacf1e9f428d6853195cfb041ef5fda997662eb",
"title": "cfacf1e9f428d6853195cfb041ef5fda997662eb",
"url": "https://r8.googlesource.com/r8/+/cfacf1e9f428d6853195cfb041ef5fda997662eb"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "cfacf1e9f428d6853195cfb041ef5fda997662eb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8955059296218175488"
},
{
"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"
}
}
[14:36:11.549] Scheduled build:
{
"id": "8789629234056179761",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 3027,
"createdBy": "project:r8",
"createTime": "2023-02-09T14:36:10.955637629Z",
"updateTime": "2023-02-09T14:36:10.955637629Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "cfacf1e9f428d6853195cfb041ef5fda997662eb",
"ref": "refs/heads/main"
}
}
}
[14:36:11.550] Task URL: https://cr-buildbucket.appspot.com/build/8789629234056179761
[14:36:11.550] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:2:0) after 5m55s
[14:42:06.569] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:2:0)
[14:42:06.849] Build status: SCHEDULED
[14:42:06.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:3:0) after 4m23s
[14:46:30.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:3:0)
[14:46:30.244] Build status: SCHEDULED
[14:46:30.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:4:0) after 7m56s
[14:54:26.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:4:0)
[14:54:26.368] Build status: SCHEDULED
[14:54:26.368] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:5:0) after 7m24s
[15:01:50.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:5:0)
[15:01:50.559] Build status: SCHEDULED
[15:01:50.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:6:0) after 7m29s
[15:09:19.725] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:6:0)
[15:09:19.746] Build status: SCHEDULED
[15:09:19.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:7:0) after 2m24s
[15:11:43.773] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:7:0)
[15:11:43.811] Build status: SCHEDULED
[15:11:43.811] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:8:0) after 1m17s
[15:13:00.829] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:8:0)
[15:13:00.851] Build status: SCHEDULED
[15:13:00.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:9:0) after 2m10s
[15:15:10.929] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:9:0)
[15:15:10.959] Build status: SCHEDULED
[15:15:10.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:10:0) after 2m21s
[15:17:31.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:10:0)
[15:17:32.102] Build status: SCHEDULED
[15:17:32.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:11:0) after 7m13s
[15:24:45.406] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:11:0)
[15:24:45.497] Build status: SCHEDULED
[15:24:45.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:12:0) after 5m38s
[15:30:23.760] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:12:0)
[15:30:23.784] Build status: SCHEDULED
[15:30:23.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:13:0) after 7m46s
[15:38:09.772] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:13:0)
[15:38:09.818] Build status: SCHEDULED
[15:38:09.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:14:0) after 3m25s
[15:41:34.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:14:0)
[15:41:34.873] Build status: SCHEDULED
[15:41:34.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:15:0) after 4m9s
[15:45:43.966] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:15:0)
[15:45:44.050] Build status: SCHEDULED
[15:45:44.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:16:0) after 1m57s
[15:47:41.126] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:16:0)
[15:47:41.151] Build status: SCHEDULED
[15:47:41.151] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:17:0) after 1m55s
[15:49:36.483] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:17:0)
[15:49:36.514] Build status: SCHEDULED
[15:49:36.514] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:18:0) after 5m57s
[15:55:33.584] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:18:0)
[15:55:33.613] Build status: SCHEDULED
[15:55:33.613] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:19:0) after 9m55s
[16:05:28.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:19:0)
[16:05:28.685] Build status: SCHEDULED
[16:05:28.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:20:0) after 7m5s
[16:12:33.707] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:20:0)
[16:12:33.759] Build status: SCHEDULED
[16:12:33.759] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:21:0) after 5m20s
[16:17:53.784] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:21:0)
[16:17:53.809] Build status: SCHEDULED
[16:17:53.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:22:0) after 2m13s
[16:20:06.828] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:22:0)
[16:20:06.849] Build status: SCHEDULED
[16:20:06.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:23:0) after 1m8s
[16:21:14.876] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:23:0)
[16:21:14.975] Build status: SCHEDULED
[16:21:14.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:24:0) after 1m30s
[16:22:45.006] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:24:0)
[16:22:45.047] Build status: SCHEDULED
[16:22:45.047] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:25:0) after 4m56s
[16:27:41.077] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:25:0)
[16:27:41.100] Build status: SCHEDULED
[16:27:41.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:26:0) after 7m18s
[16:34:59.119] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:26:0)
[16:34:59.148] Build status: SCHEDULED
[16:34:59.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:27:0) after 7m54s
[16:42:53.166] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:27:0)
[16:42:53.189] Build status: SCHEDULED
[16:42:53.189] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:28:0) after 5m50s
[16:48:43.207] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:28:0)
[16:48:43.248] Build status: SCHEDULED
[16:48:43.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:29:0) after 5m20s
[16:54:03.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:29:0)
[16:54:03.467] Build status: SCHEDULED
[16:54:03.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:30:0) after 2m9s
[16:56:12.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:30:0)
[16:56:12.719] Build status: SCHEDULED
[16:56:12.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:31:0) after 4m52s
[17:01:04.772] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:31:0)
[17:01:04.797] Build status: SCHEDULED
[17:01:04.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:32:0) after 3m23s
[17:04:27.894] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:32:0)
[17:04:27.941] Build status: SCHEDULED
[17:04:27.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:33:0) after 4m25s
[17:08:53.161] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:33:0)
[17:08:53.183] Build status: SCHEDULED
[17:08:53.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:34:0) after 4m30s
[17:13:23.203] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:34:0)
[17:13:23.263] Build status: SCHEDULED
[17:13:23.263] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:35:0) after 9m3s
[17:22:26.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:35:0)
[17:22:26.783] Build status: SCHEDULED
[17:22:26.783] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:36:0) after 4m32s
[17:26:58.802] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:36:0)
[17:26:58.824] Build status: SCHEDULED
[17:26:58.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:37:0) after 3m29s
[17:30:27.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:37:0)
[17:30:27.876] Build status: SCHEDULED
[17:30:27.876] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:38:0) after 2m9s
[17:32:37.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:38:0)
[17:32:37.050] Build status: SCHEDULED
[17:32:37.051] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:39:0) after 1m29s
[17:34:06.075] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:39:0)
[17:34:06.118] Build status: SCHEDULED
[17:34:06.118] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:40:0) after 4m36s
[17:38:42.134] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:40:0)
[17:38:42.156] Build status: SCHEDULED
[17:38:42.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:41:0) after 6m55s
[17:45:37.751] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:41:0)
[17:45:37.774] Build status: SCHEDULED
[17:45:37.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:42:0) after 6m59s
[17:52:36.808] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:42:0)
[17:52:36.838] Build status: SCHEDULED
[17:52:36.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:43:0) after 2m3s
[17:54:39.948] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:43:0)
[17:54:40.335] Build status: SCHEDULED
[17:54:40.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:44:0) after 4m45s
[17:59:25.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:44:0)
[17:59:25.453] Build status: SCHEDULED
[17:59:25.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:45:0) after 2m52s
[18:02:17.614] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:45:0)
[18:02:17.640] Build status: SCHEDULED
[18:02:17.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:46:0) after 6m7s
[18:07:23.816] Received PubSub notification, asking Buildbucket for the build status
[18:07:23.839] Build status: STARTED
[18:08:24.664] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:46:0)
[18:08:24.687] Build status: STARTED
[18:08:24.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:48:0) after 1m53s
[18:10:17.723] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:48:0)
[18:10:17.757] Build status: STARTED
[18:10:17.757] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:49:0) after 9m44s
[18:20:01.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:49:0)
[18:20:01.902] Build status: STARTED
[18:20:01.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:50:0) after 2m19s
[18:22:21.564] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:50:0)
[18:22:21.594] Build status: STARTED
[18:22:21.594] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:51:0) after 7m43s
[18:30:04.782] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:51:0)
[18:30:04.822] Build status: STARTED
[18:30:04.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:52:0) after 1m46s
[18:31:50.845] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:52:0)
[18:31:50.902] Build status: STARTED
[18:31:50.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:53:0) after 3m31s
[18:35:21.923] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:53:0)
[18:35:21.968] Build status: STARTED
[18:35:21.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:54:0) after 8m19s
[18:43:41.003] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:54:0)
[18:43:41.044] Build status: STARTED
[18:43:41.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:55:0) after 3m11s
[18:46:52.110] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:55:0)
[18:46:52.136] Build status: STARTED
[18:46:52.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:56:0) after 5m16s
[18:52:08.176] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:56:0)
[18:52:08.197] Build status: STARTED
[18:52:08.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:57:0) after 9m52s
[19:02:00.269] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:57:0)
[19:02:00.307] Build status: STARTED
[19:02:00.307] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:58:0) after 4m32s
[19:06:32.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:58:0)
[19:06:32.537] Build status: STARTED
[19:06:32.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:59:0) after 2m46s
[19:09:18.666] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:59:0)
[19:09:18.699] Build status: STARTED
[19:09:18.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:60:0) after 2m11s
[19:11:29.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:60:0)
[19:11:29.753] Build status: STARTED
[19:11:29.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:61:0) after 4m2s
[19:15:31.815] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:61:0)
[19:15:31.848] Build status: STARTED
[19:15:31.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:62:0) after 5m42s
[19:21:13.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:62:0)
[19:21:13.963] Build status: STARTED
[19:21:13.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:63:0) after 1m59s
[19:23:13.254] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:63:0)
[19:23:13.279] Build status: STARTED
[19:23:13.279] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:64:0) after 7m21s
[19:30:35.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:64:0)
[19:30:35.160] Build status: STARTED
[19:30:35.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:65:0) after 2m39s
[19:33:14.190] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:65:0)
[19:33:14.236] Build status: STARTED
[19:33:14.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:66:0) after 7m40s
[19:40:54.259] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:66:0)
[19:40:54.282] Build status: STARTED
[19:40:54.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:67:0) after 2m2s
[19:42:56.378] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:67:0)
[19:42:56.440] Build status: STARTED
[19:42:56.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:68:0) after 2m27s
[19:45:23.461] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:68:0)
[19:45:23.485] Build status: STARTED
[19:45:23.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:69:0) after 2m59s
[19:48:22.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:69:0)
[19:48:22.566] Build status: STARTED
[19:48:22.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:70:0) after 3m57s
[19:52:19.684] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:70:0)
[19:52:19.711] Build status: STARTED
[19:52:19.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:71:0) after 1m25s
[19:53:44.829] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:71:0)
[19:53:44.919] Build status: STARTED
[19:53:44.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:72:0) after 4m31s
[19:58:15.938] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:72:0)
[19:58:15.970] Build status: STARTED
[19:58:15.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:73:0) after 2m26s
[20:00:42.036] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:73:0)
[20:00:42.063] Build status: STARTED
[20:00:42.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:74:0) after 5m1s
[20:05:43.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:74:0)
[20:05:43.111] Build status: STARTED
[20:05:43.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:75:0) after 1m34s
[20:07:17.110] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:75:0)
[20:07:17.134] Build status: STARTED
[20:07:17.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:76:0) after 8m20s
[20:15:37.171] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:76:0)
[20:15:37.209] Build status: STARTED
[20:15:37.209] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:77:0) after 9m18s
[20:24:55.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:77:0)
[20:24:55.264] Build status: STARTED
[20:24:55.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:78:0) after 3m17s
[20:28:12.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:78:0)
[20:28:12.500] Build status: STARTED
[20:28:12.500] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:79:0) after 6m57s
[20:35:09.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:79:0)
[20:35:09.555] Build status: STARTED
[20:35:09.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:80:0) after 5m44s
[20:40:53.571] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:80:0)
[20:40:53.596] Build status: STARTED
[20:40:53.596] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:81:0) after 8m9s
[20:49:02.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:81:0)
[20:49:02.616] Build status: STARTED
[20:49:02.616] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:82:0) after 1m47s
[20:50:49.672] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:82:0)
[20:50:49.710] Build status: STARTED
[20:50:49.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:83:0) after 8m57s
[20:59:46.734] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:83:0)
[20:59:46.758] Build status: STARTED
[20:59:46.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:84:0) after 1m2s
[21:00:48.785] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:84:0)
[21:00:48.804] Build status: STARTED
[21:00:48.805] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:85:0) after 6m28s
[21:07:16.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:85:0)
[21:07:16.888] Build status: STARTED
[21:07:16.888] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:86:0) after 9m43s
[21:16:59.908] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:86:0)
[21:16:59.955] Build status: STARTED
[21:16:59.955] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:87:0) after 6m10s
[21:23:09.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:87:0)
[21:23:10.003] Build status: STARTED
[21:23:10.003] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:88:0) after 2m32s
[21:25:42.024] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:88:0)
[21:25:42.097] Build status: STARTED
[21:25:42.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:89:0) after 2m36s
[21:28:18.117] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:89:0)
[21:28:18.146] Build status: STARTED
[21:28:18.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:90:0) after 5m0s
[21:33:18.333] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:90:0)
[21:33:18.365] Build status: STARTED
[21:33:18.365] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:91:0) after 4m55s
[21:38:13.360] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:91:0)
[21:38:13.396] Build status: STARTED
[21:38:13.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8955059296218175488:92:0) after 1m31s
[21:38:55.095] Received PubSub notification, asking Buildbucket for the build status
[21:38:55.122] Build:
{
"id": "8789629234056179761",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 3027,
"createdBy": "project:r8",
"createTime": "2023-02-09T14:36:10.955637629Z",
"startTime": "2023-02-09T18:07:22.448162Z",
"endTime": "2023-02-09T21:38:54.928412174Z",
"updateTime": "2023-02-09T21:38:54.928412174Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "cfacf1e9f428d6853195cfb041ef5fda997662eb",
"ref": "refs/heads/main"
}
}
}
[21:38:55.122] Invocation finished in 7h2m45.613262257s with status SUCCEEDED