[20:32:54.626] New invocation is queued and will start shortly
[20:32:55.723] Starting the invocation (attempt 1)
[20:32:55.775] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f"
[20:32:55.775] Popped gitiles commit info from properties and tags
[20:32:55.775] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:32:55.775] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:32:55.776] Buildbucket request:
{
"requestId": "9017458161195773440",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "8fb133932045f7706575c7470ce92217b09c5b25"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@8fb133932045f7706575c7470ce92217b09c5b25",
"title": "8fb133932045f7706575c7470ce92217b09c5b25",
"url": "https://r8.googlesource.com/r8/+/8fb133932045f7706575c7470ce92217b09c5b25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "165906975b0e8d0aa7eeccd975786d07c689d6dd"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@165906975b0e8d0aa7eeccd975786d07c689d6dd",
"title": "165906975b0e8d0aa7eeccd975786d07c689d6dd",
"url": "https://r8.googlesource.com/r8/+/165906975b0e8d0aa7eeccd975786d07c689d6dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "bd07504ccb2d8858a7a5ad87ee1b62d5d4830797"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@bd07504ccb2d8858a7a5ad87ee1b62d5d4830797",
"title": "bd07504ccb2d8858a7a5ad87ee1b62d5d4830797",
"url": "https://r8.googlesource.com/r8/+/bd07504ccb2d8858a7a5ad87ee1b62d5d4830797"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "c777d877859ba74b66b129f9f98c2428ebfc9c1a"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@c777d877859ba74b66b129f9f98c2428ebfc9c1a",
"title": "c777d877859ba74b66b129f9f98c2428ebfc9c1a",
"url": "https://r8.googlesource.com/r8/+/c777d877859ba74b66b129f9f98c2428ebfc9c1a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "2eaf4ac5c2f6fcead6023dfe463c255e2b3fbd8b"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@2eaf4ac5c2f6fcead6023dfe463c255e2b3fbd8b",
"title": "2eaf4ac5c2f6fcead6023dfe463c255e2b3fbd8b",
"url": "https://r8.googlesource.com/r8/+/2eaf4ac5c2f6fcead6023dfe463c255e2b3fbd8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "8c15ecdc82f4e9a469ab8a922a39eeb0db0c47d9"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@8c15ecdc82f4e9a469ab8a922a39eeb0db0c47d9",
"title": "8c15ecdc82f4e9a469ab8a922a39eeb0db0c47d9",
"url": "https://r8.googlesource.com/r8/+/8c15ecdc82f4e9a469ab8a922a39eeb0db0c47d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f",
"title": "1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f",
"url": "https://r8.googlesource.com/r8/+/1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017458161195773440"
},
{
"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"
}
}
[20:32:56.461] Scheduled build:
{
"id": "8852028099201916368",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 1713,
"createdBy": "project:r8",
"createTime": "2021-03-22T20:32:55.892721Z",
"updateTime": "2021-03-22T20:32:56.297473Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f",
"ref": "refs/heads/main"
}
}
}
[20:32:56.461] Task URL: https://cr-buildbucket.appspot.com/build/8852028099201916368
[20:32:56.461] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:2:0) after 6m58s
[20:33:43.660] Received PubSub notification, asking Buildbucket for the build status
[20:33:43.693] Build status: STARTED
[20:39:54.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:2:0)
[20:39:54.630] Build status: STARTED
[20:39:54.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:4:0) after 6m34s
[20:46:28.644] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:4:0)
[20:46:28.674] Build status: STARTED
[20:46:28.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:5:0) after 1m20s
[20:47:48.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:5:0)
[20:47:48.715] Build status: STARTED
[20:47:48.715] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:6:0) after 2m35s
[20:50:23.868] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:6:0)
[20:50:23.897] Build status: STARTED
[20:50:23.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:7:0) after 4m53s
[20:55:16.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:7:0)
[20:55:17.018] Build status: STARTED
[20:55:17.018] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:8:0) after 4m28s
[20:59:45.045] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:8:0)
[20:59:45.113] Build status: STARTED
[20:59:45.113] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:9:0) after 8m50s
[21:08:35.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:9:0)
[21:08:35.303] Build status: STARTED
[21:08:35.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:10:0) after 4m34s
[21:13:09.347] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:10:0)
[21:13:09.393] Build status: STARTED
[21:13:09.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:11:0) after 5m58s
[21:19:07.411] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:11:0)
[21:19:07.454] Build status: STARTED
[21:19:07.454] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:12:0) after 9m49s
[21:28:56.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:12:0)
[21:28:56.577] Build status: STARTED
[21:28:56.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:13:0) after 3m2s
[21:31:58.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:13:0)
[21:31:59.015] Build status: STARTED
[21:31:59.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:14:0) after 4m15s
[21:36:14.356] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:14:0)
[21:36:14.416] Build status: STARTED
[21:36:14.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:15:0) after 5m22s
[21:41:36.474] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:15:0)
[21:41:36.507] Build status: STARTED
[21:41:36.507] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:16:0) after 6m56s
[21:48:32.740] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:16:0)
[21:48:32.770] Build status: STARTED
[21:48:32.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:17:0) after 8m51s
[21:57:23.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:17:0)
[21:57:23.845] Build status: STARTED
[21:57:23.845] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:18:0) after 3m34s
[22:00:58.110] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:18:0)
[22:00:58.161] Build status: STARTED
[22:00:58.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:19:0) after 5m39s
[22:06:37.517] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:19:0)
[22:06:37.553] Build status: STARTED
[22:06:37.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:20:0) after 4m1s
[22:10:38.574] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:20:0)
[22:10:38.601] Build status: STARTED
[22:10:38.601] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:21:0) after 1m58s
[22:12:36.620] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:21:0)
[22:12:36.694] Build status: STARTED
[22:12:36.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:22:0) after 9m26s
[22:22:02.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:22:0)
[22:22:02.773] Build status: STARTED
[22:22:02.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:23:0) after 6m13s
[22:28:15.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:23:0)
[22:28:15.924] Build status: STARTED
[22:28:15.924] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:24:0) after 6m53s
[22:35:08.941] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:24:0)
[22:35:08.972] Build status: STARTED
[22:35:08.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:25:0) after 2m18s
[22:37:26.997] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:25:0)
[22:37:27.040] Build status: STARTED
[22:37:27.040] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:26:0) after 8m1s
[22:45:28.058] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:26:0)
[22:45:28.104] Build status: STARTED
[22:45:28.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:27:0) after 8m52s
[22:54:20.491] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:27:0)
[22:54:20.520] Build status: STARTED
[22:54:20.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:28:0) after 9m48s
[23:04:08.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:28:0)
[23:04:09.018] Build status: STARTED
[23:04:09.018] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:29:0) after 6m4s
[23:10:13.199] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:29:0)
[23:10:13.231] Build status: STARTED
[23:10:13.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:30:0) after 4m2s
[23:14:15.350] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:30:0)
[23:14:15.374] Build status: STARTED
[23:14:15.374] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:31:0) after 9m11s
[23:23:26.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:31:0)
[23:23:26.544] Build status: STARTED
[23:23:26.544] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:32:0) after 5m56s
[23:29:22.566] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:32:0)
[23:29:22.601] Build status: STARTED
[23:29:22.601] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:33:0) after 4m52s
[23:34:14.726] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:33:0)
[23:34:14.809] Build status: STARTED
[23:34:14.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:34:0) after 2m38s
[23:36:53.030] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:34:0)
[23:36:53.061] Build status: STARTED
[23:36:53.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:35:0) after 8m28s
[23:45:21.168] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:35:0)
[23:45:21.200] Build status: STARTED
[23:45:21.200] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:36:0) after 8m15s
[23:53:36.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:36:0)
[23:53:36.289] Build status: STARTED
[23:53:36.289] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:37:0) after 9m42s
[00:03:18.390] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:37:0)
[00:03:18.443] Build status: STARTED
[00:03:18.443] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:38:0) after 4m1s
[00:07:19.625] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:38:0)
[00:07:19.654] Build status: STARTED
[00:07:19.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:39:0) after 3m56s
[00:11:15.849] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:39:0)
[00:11:16.038] Build status: STARTED
[00:11:16.038] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:40:0) after 9m41s
[00:20:57.072] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:40:0)
[00:20:57.099] Build status: STARTED
[00:20:57.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:41:0) after 5m48s
[00:26:45.210] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:41:0)
[00:26:45.247] Build status: STARTED
[00:26:45.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:42:0) after 3m42s
[00:30:27.227] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:42:0)
[00:30:27.262] Build status: STARTED
[00:30:27.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:43:0) after 2m11s
[00:32:38.323] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:43:0)
[00:32:38.384] Build status: STARTED
[00:32:38.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:44:0) after 6m29s
[00:39:07.496] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:44:0)
[00:39:07.523] Build status: STARTED
[00:39:07.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:45:0) after 5m33s
[00:44:40.771] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:45:0)
[00:44:40.802] Build status: STARTED
[00:44:40.802] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:46:0) after 3m7s
[00:47:47.905] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:46:0)
[00:47:47.935] Build status: STARTED
[00:47:47.935] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:47:0) after 1m28s
[00:49:16.162] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:47:0)
[00:49:16.195] Build status: STARTED
[00:49:16.195] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:48:0) after 2m10s
[00:51:26.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:48:0)
[00:51:26.301] Build status: STARTED
[00:51:26.301] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:49:0) after 7m28s
[00:58:54.396] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:49:0)
[00:58:54.430] Build status: STARTED
[00:58:54.430] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:50:0) after 3m51s
[01:02:46.051] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:50:0)
[01:02:46.091] Build status: STARTED
[01:02:46.091] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:51:0) after 2m39s
[01:05:25.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:51:0)
[01:05:25.305] Build status: STARTED
[01:05:25.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:52:0) after 8m43s
[01:14:08.540] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:52:0)
[01:14:08.574] Build status: STARTED
[01:14:08.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:53:0) after 3m50s
[01:17:58.740] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:53:0)
[01:17:58.767] Build status: STARTED
[01:17:58.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:54:0) after 2m6s
[01:20:04.894] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:54:0)
[01:20:04.926] Build status: STARTED
[01:20:04.926] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:55:0) after 2m40s
[01:22:45.149] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:55:0)
[01:22:45.182] Build status: STARTED
[01:22:45.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:56:0) after 5m19s
[01:28:04.208] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:56:0)
[01:28:04.232] Build status: STARTED
[01:28:04.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:57:0) after 4m21s
[01:32:25.399] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:57:0)
[01:32:25.461] Build status: STARTED
[01:32:25.461] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:58:0) after 4m24s
[01:36:49.619] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:58:0)
[01:36:49.660] Build status: STARTED
[01:36:49.660] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:59:0) after 6m30s
[01:43:19.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:59:0)
[01:43:19.720] Build status: STARTED
[01:43:19.720] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:60:0) after 1m8s
[01:44:27.947] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:60:0)
[01:44:27.986] Build status: STARTED
[01:44:27.986] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:61:0) after 4m48s
[01:49:16.115] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:61:0)
[01:49:16.184] Build status: STARTED
[01:49:16.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:62:0) after 5m41s
[01:54:57.321] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:62:0)
[01:54:57.407] Build status: STARTED
[01:54:57.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:63:0) after 2m21s
[01:57:18.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:63:0)
[01:57:18.453] Build status: STARTED
[01:57:18.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:64:0) after 3m55s
[02:01:13.483] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:64:0)
[02:01:13.512] Build status: STARTED
[02:01:13.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:65:0) after 5m31s
[02:06:44.537] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:65:0)
[02:06:44.570] Build status: STARTED
[02:06:44.570] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:66:0) after 4m38s
[02:11:22.720] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:66:0)
[02:11:22.760] Build status: STARTED
[02:11:22.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:67:0) after 8m51s
[02:20:13.781] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:67:0)
[02:20:13.824] Build status: STARTED
[02:20:13.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:68:0) after 3m56s
[02:24:09.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:68:0)
[02:24:09.876] Build status: STARTED
[02:24:09.876] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:69:0) after 8m4s
[02:32:14.000] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:69:0)
[02:32:14.032] Build status: STARTED
[02:32:14.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:70:0) after 7m20s
[02:39:34.107] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:70:0)
[02:39:34.134] Build status: STARTED
[02:39:34.134] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:71:0) after 8m15s
[02:47:49.122] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:71:0)
[02:47:49.155] Build status: STARTED
[02:47:49.155] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9017458161195773440:72:0) after 6m11s
[02:53:15.735] Received PubSub notification, asking Buildbucket for the build status
[02:53:15.768] Build:
{
"id": "8852028099201916368",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 1713,
"createdBy": "project:r8",
"createTime": "2021-03-22T20:32:55.892721Z",
"startTime": "2021-03-22T20:33:42.754558Z",
"endTime": "2021-03-23T02:53:14.408148Z",
"updateTime": "2021-03-23T02:53:15.482706Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "1c28c2f9d06f315ddd5f4f1ff6fa43b6d234fe0f",
"ref": "refs/heads/main"
}
}
}
[02:53:15.768] Invocation finished in 6h20m21.161234561s with status SUCCEEDED