[19:42:36.127] New invocation is queued and will start shortly
[19:42:37.222] Starting the invocation (attempt 1)
[19:42:37.258] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/8c510fab0fc7bc78f1b861353b957df7bd8e5d5a"
[19:42:37.259] Popped gitiles commit info from properties and tags
[19:42:37.259] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:42:37.259] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:42:37.260] Buildbucket request:
{
"requestId": "8997077008878781712",
"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": "603badde3524fba5ba6078b8669294df2171ccc1"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@603badde3524fba5ba6078b8669294df2171ccc1",
"title": "603badde3524fba5ba6078b8669294df2171ccc1",
"url": "https://r8.googlesource.com/r8/+/603badde3524fba5ba6078b8669294df2171ccc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "6f6ef24f88c111507ea27cbf548dc0c5f6bbf721"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@6f6ef24f88c111507ea27cbf548dc0c5f6bbf721",
"title": "6f6ef24f88c111507ea27cbf548dc0c5f6bbf721",
"url": "https://r8.googlesource.com/r8/+/6f6ef24f88c111507ea27cbf548dc0c5f6bbf721"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "d0358c536d74cc7359f99371b554ef50f70f1cc4"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@d0358c536d74cc7359f99371b554ef50f70f1cc4",
"title": "d0358c536d74cc7359f99371b554ef50f70f1cc4",
"url": "https://r8.googlesource.com/r8/+/d0358c536d74cc7359f99371b554ef50f70f1cc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "5eddb3987a5140f150bf67a3476b197d9259ed6e"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@5eddb3987a5140f150bf67a3476b197d9259ed6e",
"title": "5eddb3987a5140f150bf67a3476b197d9259ed6e",
"url": "https://r8.googlesource.com/r8/+/5eddb3987a5140f150bf67a3476b197d9259ed6e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "944259d4d0bbc453c6cd01d51ea704a237fd449b"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@944259d4d0bbc453c6cd01d51ea704a237fd449b",
"title": "944259d4d0bbc453c6cd01d51ea704a237fd449b",
"url": "https://r8.googlesource.com/r8/+/944259d4d0bbc453c6cd01d51ea704a237fd449b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "e3e1b1c8bd0d4f3641f4a347a6e15ecee2aa0dc5"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@e3e1b1c8bd0d4f3641f4a347a6e15ecee2aa0dc5",
"title": "e3e1b1c8bd0d4f3641f4a347a6e15ecee2aa0dc5",
"url": "https://r8.googlesource.com/r8/+/e3e1b1c8bd0d4f3641f4a347a6e15ecee2aa0dc5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "14229f5c62b5ef74d80cb668a5ada0c09e2b08d0"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@14229f5c62b5ef74d80cb668a5ada0c09e2b08d0",
"title": "14229f5c62b5ef74d80cb668a5ada0c09e2b08d0",
"url": "https://r8.googlesource.com/r8/+/14229f5c62b5ef74d80cb668a5ada0c09e2b08d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "b4253655dca7344310fc4c7787ca01f91c27a2f3"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@b4253655dca7344310fc4c7787ca01f91c27a2f3",
"title": "b4253655dca7344310fc4c7787ca01f91c27a2f3",
"url": "https://r8.googlesource.com/r8/+/b4253655dca7344310fc4c7787ca01f91c27a2f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "1fed861fadaf405444c9dc621fb6bb92fda6ba3c"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@1fed861fadaf405444c9dc621fb6bb92fda6ba3c",
"title": "1fed861fadaf405444c9dc621fb6bb92fda6ba3c",
"url": "https://r8.googlesource.com/r8/+/1fed861fadaf405444c9dc621fb6bb92fda6ba3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "6c07dc307584abb6f8f4c2c61a8958f2f9fa66fa"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@6c07dc307584abb6f8f4c2c61a8958f2f9fa66fa",
"title": "6c07dc307584abb6f8f4c2c61a8958f2f9fa66fa",
"url": "https://r8.googlesource.com/r8/+/6c07dc307584abb6f8f4c2c61a8958f2f9fa66fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "6aa4ea37c4c934982aa4bbb3fcd7a6df9bbf1004"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@6aa4ea37c4c934982aa4bbb3fcd7a6df9bbf1004",
"title": "6aa4ea37c4c934982aa4bbb3fcd7a6df9bbf1004",
"url": "https://r8.googlesource.com/r8/+/6aa4ea37c4c934982aa4bbb3fcd7a6df9bbf1004"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "6b3fa5e7b50e5dd9f266d2a721d17082f707c492"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@6b3fa5e7b50e5dd9f266d2a721d17082f707c492",
"title": "6b3fa5e7b50e5dd9f266d2a721d17082f707c492",
"url": "https://r8.googlesource.com/r8/+/6b3fa5e7b50e5dd9f266d2a721d17082f707c492"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "a550ab3160fe4854eeda5ae2040c93ab82073614"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@a550ab3160fe4854eeda5ae2040c93ab82073614",
"title": "a550ab3160fe4854eeda5ae2040c93ab82073614",
"url": "https://r8.googlesource.com/r8/+/a550ab3160fe4854eeda5ae2040c93ab82073614"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "e88a7cfbfcce5cc1c28585c2803a3f2346cdf45c"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@e88a7cfbfcce5cc1c28585c2803a3f2346cdf45c",
"title": "e88a7cfbfcce5cc1c28585c2803a3f2346cdf45c",
"url": "https://r8.googlesource.com/r8/+/e88a7cfbfcce5cc1c28585c2803a3f2346cdf45c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "6473ca249e5e259c3b737cdaa23bd29d0af6b439"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@6473ca249e5e259c3b737cdaa23bd29d0af6b439",
"title": "6473ca249e5e259c3b737cdaa23bd29d0af6b439",
"url": "https://r8.googlesource.com/r8/+/6473ca249e5e259c3b737cdaa23bd29d0af6b439"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "7d536c85ff84b67e0c2eafcc82ca3c9f4a25bef8"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@7d536c85ff84b67e0c2eafcc82ca3c9f4a25bef8",
"title": "7d536c85ff84b67e0c2eafcc82ca3c9f4a25bef8",
"url": "https://r8.googlesource.com/r8/+/7d536c85ff84b67e0c2eafcc82ca3c9f4a25bef8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "c2842df8b153243a3fa47c1c88f6481412dcfb52"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@c2842df8b153243a3fa47c1c88f6481412dcfb52",
"title": "c2842df8b153243a3fa47c1c88f6481412dcfb52",
"url": "https://r8.googlesource.com/r8/+/c2842df8b153243a3fa47c1c88f6481412dcfb52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "8c510fab0fc7bc78f1b861353b957df7bd8e5d5a"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@8c510fab0fc7bc78f1b861353b957df7bd8e5d5a",
"title": "8c510fab0fc7bc78f1b861353b957df7bd8e5d5a",
"url": "https://r8.googlesource.com/r8/+/8c510fab0fc7bc78f1b861353b957df7bd8e5d5a"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8c510fab0fc7bc78f1b861353b957df7bd8e5d5a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8997077008878781712"
},
{
"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"
}
}
[19:42:37.836] Scheduled build:
{
"id": "8831646946961293409",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 2180,
"createdBy": "project:r8",
"createTime": "2021-11-02T19:42:37.323408159Z",
"updateTime": "2021-11-02T19:42:37.323408159Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8c510fab0fc7bc78f1b861353b957df7bd8e5d5a",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:42:37.836] Task URL: https://cr-buildbucket.appspot.com/build/8831646946961293409
[19:42:37.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:2:0) after 5m39s
[19:48:16.996] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:2:0)
[19:48:17.172] Build status: SCHEDULED
[19:48:17.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:3:0) after 4m0s
[19:52:17.390] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:3:0)
[19:52:17.423] Build status: SCHEDULED
[19:52:17.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:4:0) after 6m52s
[19:59:09.493] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:4:0)
[19:59:09.534] Build status: SCHEDULED
[19:59:09.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:5:0) after 7m35s
[20:06:44.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:5:0)
[20:06:44.695] Build status: SCHEDULED
[20:06:44.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:6:0) after 7m43s
[20:14:27.719] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:6:0)
[20:14:27.822] Build status: SCHEDULED
[20:14:27.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:7:0) after 4m8s
[20:18:35.917] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:7:0)
[20:18:35.950] Build status: SCHEDULED
[20:18:35.950] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:8:0) after 2m44s
[20:21:19.968] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:8:0)
[20:21:19.998] Build status: SCHEDULED
[20:21:19.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:9:0) after 1m44s
[20:23:04.017] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:9:0)
[20:23:04.054] Build status: SCHEDULED
[20:23:04.054] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:10:0) after 1m51s
[20:24:55.200] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:10:0)
[20:24:55.494] Build status: SCHEDULED
[20:24:55.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:11:0) after 1m2s
[20:25:57.550] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:11:0)
[20:25:57.592] Build status: SCHEDULED
[20:25:57.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:12:0) after 5m0s
[20:30:57.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:12:0)
[20:30:57.778] Build status: SCHEDULED
[20:30:57.778] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:13:0) after 8m23s
[20:39:20.796] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:13:0)
[20:39:20.827] Build status: SCHEDULED
[20:39:20.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:14:0) after 7m36s
[20:46:56.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:14:0)
[20:46:56.898] Build status: SCHEDULED
[20:46:56.898] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:15:0) after 6m17s
[20:53:14.115] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:15:0)
[20:53:14.148] Build status: SCHEDULED
[20:53:14.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:16:0) after 7m14s
[21:00:28.153] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:16:0)
[21:00:28.190] Build status: SCHEDULED
[21:00:28.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:17:0) after 5m9s
[21:05:37.217] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:17:0)
[21:05:37.290] Build status: SCHEDULED
[21:05:37.290] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:18:0) after 3m15s
[21:08:52.554] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:18:0)
[21:08:52.607] Build status: SCHEDULED
[21:08:52.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:19:0) after 8m52s
[21:17:45.362] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:19:0)
[21:17:45.396] Build status: SCHEDULED
[21:17:45.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:20:0) after 2m31s
[21:20:16.714] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:20:0)
[21:20:16.758] Build status: SCHEDULED
[21:20:16.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:21:0) after 4m29s
[21:24:45.745] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:21:0)
[21:24:45.780] Build status: SCHEDULED
[21:24:45.780] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:22:0) after 1m24s
[21:26:09.860] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:22:0)
[21:26:09.903] Build status: SCHEDULED
[21:26:09.903] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:23:0) after 1m49s
[21:27:58.878] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:23:0)
[21:27:58.969] Build status: SCHEDULED
[21:27:58.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:24:0) after 8m39s
[21:36:38.011] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:24:0)
[21:36:38.059] Build status: SCHEDULED
[21:36:38.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:25:0) after 9m3s
[21:45:41.171] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:25:0)
[21:45:41.217] Build status: SCHEDULED
[21:45:41.217] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:26:0) after 1m47s
[21:47:28.445] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:26:0)
[21:47:28.485] Build status: SCHEDULED
[21:47:28.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:27:0) after 2m20s
[21:49:48.519] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:27:0)
[21:49:48.554] Build status: SCHEDULED
[21:49:48.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:28:0) after 3m1s
[21:52:49.650] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:28:0)
[21:52:49.680] Build status: SCHEDULED
[21:52:49.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:29:0) after 3m7s
[21:55:56.804] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:29:0)
[21:55:56.837] Build status: SCHEDULED
[21:55:56.837] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:30:0) after 6m41s
[22:02:38.193] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:30:0)
[22:02:38.233] Build status: SCHEDULED
[22:02:38.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:31:0) after 4m54s
[22:07:32.637] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:31:0)
[22:07:32.678] Build status: SCHEDULED
[22:07:32.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:32:0) after 6m23s
[22:13:55.707] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:32:0)
[22:13:55.741] Build status: SCHEDULED
[22:13:55.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:33:0) after 7m3s
[22:20:58.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:33:0)
[22:20:58.797] Build status: SCHEDULED
[22:20:58.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:34:0) after 1m3s
[22:22:01.863] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:34:0)
[22:22:01.911] Build status: SCHEDULED
[22:22:01.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:35:0) after 6m52s
[22:28:53.896] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:35:0)
[22:28:53.984] Build status: SCHEDULED
[22:28:53.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:36:0) after 8m57s
[22:37:51.270] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:36:0)
[22:37:51.296] Build status: SCHEDULED
[22:37:51.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:37:0) after 4m15s
[22:42:06.356] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:37:0)
[22:42:06.392] Build status: SCHEDULED
[22:42:06.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:38:0) after 9m52s
[22:51:58.648] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:38:0)
[22:51:58.683] Build status: SCHEDULED
[22:51:58.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:39:0) after 5m13s
[22:57:11.813] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:39:0)
[22:57:11.846] Build status: SCHEDULED
[22:57:11.846] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:40:0) after 8m49s
[23:06:00.901] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:40:0)
[23:06:00.992] Build status: SCHEDULED
[23:06:00.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:41:0) after 2m48s
[23:08:49.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:41:0)
[23:08:49.097] Build status: SCHEDULED
[23:08:49.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:42:0) after 7m10s
[23:15:59.121] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:42:0)
[23:15:59.158] Build status: SCHEDULED
[23:15:59.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:43:0) after 6m13s
[23:22:12.279] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:43:0)
[23:22:12.316] Build status: SCHEDULED
[23:22:12.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:44:0) after 6m48s
[23:29:00.595] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:44:0)
[23:29:00.636] Build status: SCHEDULED
[23:29:00.636] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:45:0) after 8m25s
[23:37:25.765] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:45:0)
[23:37:25.803] Build status: SCHEDULED
[23:37:25.803] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:46:0) after 5m18s
[23:42:43.825] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:46:0)
[23:42:43.861] Build status: SCHEDULED
[23:42:43.861] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:47:0) after 4m56s
[23:47:39.884] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:47:0)
[23:47:39.915] Build status: SCHEDULED
[23:47:39.915] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:48:0) after 1m52s
[23:49:32.310] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:48:0)
[23:49:32.398] Build status: SCHEDULED
[23:49:32.398] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:49:0) after 4m43s
[23:54:15.427] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:49:0)
[23:54:15.487] Build status: SCHEDULED
[23:54:15.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:50:0) after 1m54s
[23:56:09.481] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:50:0)
[23:56:09.510] Build status: SCHEDULED
[23:56:09.510] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:51:0) after 1m25s
[23:57:34.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:51:0)
[23:57:34.801] Build status: SCHEDULED
[23:57:34.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:52:0) after 6m25s
[00:03:59.832] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:52:0)
[00:03:59.865] Build status: SCHEDULED
[00:03:59.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:53:0) after 8m52s
[00:12:51.890] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:53:0)
[00:12:51.923] Build status: SCHEDULED
[00:12:51.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:54:0) after 5m53s
[00:18:44.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:54:0)
[00:18:44.981] Build status: SCHEDULED
[00:18:44.981] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:55:0) after 3m20s
[00:22:05.323] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:55:0)
[00:22:05.388] Build status: SCHEDULED
[00:22:05.388] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:56:0) after 7m34s
[00:29:39.493] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:56:0)
[00:29:39.527] Build status: SCHEDULED
[00:29:39.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:57:0) after 1m17s
[00:30:56.554] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:57:0)
[00:30:56.592] Build status: SCHEDULED
[00:30:56.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:58:0) after 8m51s
[00:39:47.682] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:58:0)
[00:39:47.719] Build status: SCHEDULED
[00:39:47.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:59:0) after 2m48s
[00:42:35.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:59:0)
[00:42:35.954] Build status: SCHEDULED
[00:42:35.954] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:60:0) after 9m57s
[00:52:33.097] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:60:0)
[00:52:33.127] Build status: SCHEDULED
[00:52:33.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:61:0) after 6m37s
[00:59:10.413] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:61:0)
[00:59:10.446] Build status: SCHEDULED
[00:59:10.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:62:0) after 6m26s
[01:05:36.548] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:62:0)
[01:05:36.583] Build status: SCHEDULED
[01:05:36.583] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:63:0) after 3m27s
[01:09:03.911] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:63:0)
[01:09:03.948] Build status: SCHEDULED
[01:09:03.948] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:64:0) after 6m9s
[01:15:13.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:64:0)
[01:15:13.219] Build status: SCHEDULED
[01:15:13.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:65:0) after 2m11s
[01:17:24.303] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:65:0)
[01:17:24.351] Build status: SCHEDULED
[01:17:24.351] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:66:0) after 4m34s
[01:21:58.469] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:66:0)
[01:21:58.499] Build status: SCHEDULED
[01:21:58.499] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:67:0) after 3m43s
[01:25:41.521] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:67:0)
[01:25:41.554] Build status: SCHEDULED
[01:25:41.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:68:0) after 8m37s
[01:34:18.954] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:68:0)
[01:34:18.993] Build status: SCHEDULED
[01:34:18.993] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:69:0) after 6m35s
[01:40:54.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:69:0)
[01:40:54.276] Build status: SCHEDULED
[01:40:54.276] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:70:0) after 8m3s
[01:48:57.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:70:0)
[01:48:57.795] Build status: SCHEDULED
[01:48:57.795] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:71:0) after 4m35s
[01:53:33.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:71:0)
[01:53:33.092] Build status: SCHEDULED
[01:53:33.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:72:0) after 3m23s
[01:56:56.294] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:72:0)
[01:56:56.400] Build status: SCHEDULED
[01:56:56.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:73:0) after 5m25s
[02:02:21.845] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:73:0)
[02:02:21.881] Build status: SCHEDULED
[02:02:21.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:74:0) after 3m29s
[02:05:50.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:74:0)
[02:05:50.938] Build status: SCHEDULED
[02:05:50.938] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:75:0) after 2m25s
[02:08:16.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:75:0)
[02:08:16.146] Build status: SCHEDULED
[02:08:16.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:76:0) after 6m27s
[02:14:43.244] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:76:0)
[02:14:43.285] Build status: SCHEDULED
[02:14:43.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:77:0) after 2m9s
[02:16:52.433] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:77:0)
[02:16:52.463] Build status: SCHEDULED
[02:16:52.463] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:78:0) after 7m32s
[02:24:24.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:78:0)
[02:24:24.969] Build status: SCHEDULED
[02:24:24.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:79:0) after 6m19s
[02:30:43.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:79:0)
[02:30:44.021] Build status: SCHEDULED
[02:30:44.021] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:80:0) after 6m44s
[02:37:28.086] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:80:0)
[02:37:28.121] Build status: SCHEDULED
[02:37:28.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:81:0) after 9m8s
[02:46:36.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:81:0)
[02:46:36.188] Build status: SCHEDULED
[02:46:36.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:82:0) after 8m17s
[02:54:53.284] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:82:0)
[02:54:53.323] Build status: SCHEDULED
[02:54:53.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:83:0) after 5m35s
[03:00:28.385] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:83:0)
[03:00:28.426] Build status: SCHEDULED
[03:00:28.426] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:84:0) after 4m6s
[03:04:35.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:84:0)
[03:04:35.138] Build status: SCHEDULED
[03:04:35.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:85:0) after 1m41s
[03:06:16.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:85:0)
[03:06:16.237] Build status: SCHEDULED
[03:06:16.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:86:0) after 1m1s
[03:07:17.361] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:86:0)
[03:07:17.485] Build status: SCHEDULED
[03:07:17.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:87:0) after 4m46s
[03:12:03.760] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:87:0)
[03:12:03.806] Build status: SCHEDULED
[03:12:03.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:88:0) after 7m46s
[03:19:49.891] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:88:0)
[03:19:49.929] Build status: SCHEDULED
[03:19:49.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:89:0) after 7m7s
[03:26:56.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:89:0)
[03:26:56.977] Build status: SCHEDULED
[03:26:56.977] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:90:0) after 9m18s
[03:36:15.189] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:90:0)
[03:36:15.220] Build status: SCHEDULED
[03:36:15.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:91:0) after 6m16s
[03:42:31.347] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:91:0)
[03:42:31.378] Build status: SCHEDULED
[03:42:31.378] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:92:0) after 4m35s
[03:47:06.515] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:92:0)
[03:47:06.557] Build status: SCHEDULED
[03:47:06.557] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:93:0) after 7m36s
[03:54:42.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:93:0)
[03:54:42.867] Build status: SCHEDULED
[03:54:42.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:94:0) after 7m38s
[04:02:21.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:94:0)
[04:02:21.187] Build status: SCHEDULED
[04:02:21.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:95:0) after 1m37s
[04:03:58.308] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:95:0)
[04:03:58.340] Build status: SCHEDULED
[04:03:58.340] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:96:0) after 5m55s
[04:09:53.515] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:96:0)
[04:09:53.647] Build status: SCHEDULED
[04:09:53.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:97:0) after 2m58s
[04:12:51.753] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:97:0)
[04:12:51.801] Build status: SCHEDULED
[04:12:51.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:98:0) after 4m20s
[04:17:11.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:98:0)
[04:17:11.901] Build status: SCHEDULED
[04:17:11.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:99:0) after 1m12s
[04:18:24.167] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:99:0)
[04:18:24.195] Build status: SCHEDULED
[04:18:24.195] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:100:0) after 4m23s
[04:22:47.654] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:100:0)
[04:22:47.707] Build status: SCHEDULED
[04:22:47.707] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:101:0) after 5m7s
[04:27:54.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:101:0)
[04:27:54.864] Build status: SCHEDULED
[04:27:54.864] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:102:0) after 8m27s
[04:36:21.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:102:0)
[04:36:21.935] Build status: SCHEDULED
[04:36:21.935] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:103:0) after 1m11s
[04:37:32.970] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:103:0)
[04:37:33.000] Build status: SCHEDULED
[04:37:33.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:104:0) after 2m10s
[04:39:43.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:104:0)
[04:39:43.156] Build status: SCHEDULED
[04:39:43.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:105:0) after 3m16s
[04:42:59.143] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:105:0)
[04:42:59.194] Build status: SCHEDULED
[04:42:59.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:106:0) after 6m22s
[04:49:21.216] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:106:0)
[04:49:21.253] Build status: SCHEDULED
[04:49:21.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:107:0) after 2m19s
[04:51:40.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:107:0)
[04:51:40.470] Build status: SCHEDULED
[04:51:40.470] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:108:0) after 6m31s
[04:58:11.655] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:108:0)
[04:58:11.747] Build status: SCHEDULED
[04:58:11.747] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:109:0) after 8m20s
[05:06:31.872] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:109:0)
[05:06:31.920] Build status: SCHEDULED
[05:06:31.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:110:0) after 9m22s
[05:15:53.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:110:0)
[05:15:54.064] Build status: SCHEDULED
[05:15:54.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:111:0) after 5m59s
[05:21:53.093] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:111:0)
[05:21:53.123] Build status: SCHEDULED
[05:21:53.123] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:112:0) after 6m55s
[05:28:48.172] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:112:0)
[05:28:48.207] Build status: SCHEDULED
[05:28:48.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:113:0) after 2m18s
[05:31:06.237] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:113:0)
[05:31:06.273] Build status: SCHEDULED
[05:31:06.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:114:0) after 7m23s
[05:38:29.439] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:114:0)
[05:38:29.470] Build status: SCHEDULED
[05:38:29.470] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:115:0) after 1m43s
[05:40:12.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:115:0)
[05:40:12.538] Build status: SCHEDULED
[05:40:12.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:116:0) after 8m22s
[05:48:34.679] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:116:0)
[05:48:34.716] Build status: SCHEDULED
[05:48:34.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:117:0) after 6m3s
[05:54:37.819] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:117:0)
[05:54:37.889] Build status: SCHEDULED
[05:54:37.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:118:0) after 4m13s
[05:58:50.913] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:118:0)
[05:58:50.941] Build status: SCHEDULED
[05:58:50.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:119:0) after 4m25s
[06:03:15.971] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:119:0)
[06:03:16.003] Build status: SCHEDULED
[06:03:16.003] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:120:0) after 8m38s
[06:11:54.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:120:0)
[06:11:54.182] Build status: SCHEDULED
[06:11:54.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:121:0) after 9m46s
[06:21:40.448] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:121:0)
[06:21:40.483] Build status: SCHEDULED
[06:21:40.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:122:0) after 7m56s
[06:29:36.713] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:122:0)
[06:29:36.742] Build status: SCHEDULED
[06:29:36.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:123:0) after 1m35s
[06:31:11.785] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:123:0)
[06:31:11.964] Build status: SCHEDULED
[06:31:11.964] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:124:0) after 2m3s
[06:33:14.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:124:0)
[06:33:15.031] Build status: SCHEDULED
[06:33:15.031] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:125:0) after 3m3s
[06:36:18.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:125:0)
[06:36:18.498] Build status: SCHEDULED
[06:36:18.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:126:0) after 9m10s
[06:45:28.573] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:126:0)
[06:45:28.600] Build status: SCHEDULED
[06:45:28.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:127:0) after 8m14s
[06:53:42.619] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:127:0)
[06:53:42.671] Build status: SCHEDULED
[06:53:42.671] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:128:0) after 5m28s
[06:59:10.786] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:128:0)
[06:59:10.816] Build status: SCHEDULED
[06:59:10.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:129:0) after 2m20s
[07:01:30.845] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:129:0)
[07:01:30.956] Build status: SCHEDULED
[07:01:30.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:130:0) after 1m23s
[07:02:54.100] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:130:0)
[07:02:54.143] Build status: SCHEDULED
[07:02:54.143] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:131:0) after 7m37s
[07:10:31.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:131:0)
[07:10:31.229] Build status: SCHEDULED
[07:10:31.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:132:0) after 2m27s
[07:12:58.228] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:132:0)
[07:12:58.293] Build status: SCHEDULED
[07:12:58.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:133:0) after 6m45s
[07:19:43.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:133:0)
[07:19:43.377] Build status: SCHEDULED
[07:19:43.377] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:134:0) after 6m11s
[07:25:54.506] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:134:0)
[07:25:54.541] Build status: SCHEDULED
[07:25:54.541] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:135:0) after 7m20s
[07:33:14.755] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:135:0)
[07:33:14.827] Build status: SCHEDULED
[07:33:14.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:136:0) after 4m47s
[07:38:01.862] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:136:0)
[07:38:01.893] Build status: SCHEDULED
[07:38:01.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:137:0) after 9m19s
[07:47:21.290] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:137:0)
[07:47:21.319] Build status: SCHEDULED
[07:47:21.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:138:0) after 4m57s
[07:50:06.193] Received PubSub notification, asking Buildbucket for the build status
[07:50:06.225] Build status: STARTED
[07:52:18.337] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:138:0)
[07:52:18.367] Build status: STARTED
[07:52:18.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:140:0) after 8m3s
[08:00:21.466] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:140:0)
[08:00:21.502] Build status: STARTED
[08:00:21.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:141:0) after 8m17s
[08:08:38.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:141:0)
[08:08:39.019] Build status: STARTED
[08:08:39.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:142:0) after 5m16s
[08:13:55.046] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:142:0)
[08:13:55.093] Build status: STARTED
[08:13:55.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:143:0) after 4m59s
[08:18:54.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:143:0)
[08:18:54.261] Build status: STARTED
[08:18:54.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:144:0) after 5m24s
[08:24:18.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:144:0)
[08:24:18.466] Build status: STARTED
[08:24:18.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:145:0) after 9m7s
[08:33:25.589] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:145:0)
[08:33:25.622] Build status: STARTED
[08:33:25.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:146:0) after 9m7s
[08:42:32.685] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:146:0)
[08:42:32.719] Build status: STARTED
[08:42:32.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:147:0) after 1m5s
[08:43:37.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:147:0)
[08:43:37.781] Build status: STARTED
[08:43:37.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:148:0) after 8m25s
[08:52:03.276] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:148:0)
[08:52:03.348] Build status: STARTED
[08:52:03.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:149:0) after 6m40s
[08:58:43.547] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:149:0)
[08:58:43.585] Build status: STARTED
[08:58:43.585] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:150:0) after 8m41s
[09:07:24.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:150:0)
[09:07:24.669] Build status: STARTED
[09:07:24.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:151:0) after 7m43s
[09:15:07.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:151:0)
[09:15:07.900] Build status: STARTED
[09:15:07.900] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:152:0) after 3m39s
[09:18:46.948] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:152:0)
[09:18:46.987] Build status: STARTED
[09:18:46.987] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:153:0) after 6m40s
[09:25:27.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:153:0)
[09:25:27.048] Build status: STARTED
[09:25:27.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:154:0) after 8m16s
[09:33:43.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:154:0)
[09:33:43.167] Build status: STARTED
[09:33:43.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:155:0) after 8m13s
[09:41:56.297] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:155:0)
[09:41:56.333] Build status: STARTED
[09:41:56.333] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:156:0) after 5m46s
[09:47:42.354] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:156:0)
[09:47:42.385] Build status: STARTED
[09:47:42.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:157:0) after 7m44s
[09:55:26.521] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:157:0)
[09:55:26.601] Build status: STARTED
[09:55:26.601] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:158:0) after 7m18s
[10:02:44.615] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:158:0)
[10:02:44.690] Build status: STARTED
[10:02:44.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:159:0) after 1m50s
[10:04:34.811] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:159:0)
[10:04:34.862] Build status: STARTED
[10:04:34.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:160:0) after 2m11s
[10:06:45.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:160:0)
[10:06:46.020] Build status: STARTED
[10:06:46.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:161:0) after 6m8s
[10:12:54.222] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:161:0)
[10:12:54.253] Build status: STARTED
[10:12:54.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:162:0) after 7m38s
[10:20:32.294] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:162:0)
[10:20:32.328] Build status: STARTED
[10:20:32.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:163:0) after 9m14s
[10:29:46.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:163:0)
[10:29:46.468] Build status: STARTED
[10:29:46.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:164:0) after 5m49s
[10:35:35.492] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:164:0)
[10:35:35.526] Build status: STARTED
[10:35:35.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:165:0) after 9m5s
[10:44:40.560] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:165:0)
[10:44:40.588] Build status: STARTED
[10:44:40.588] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:166:0) after 4m45s
[10:49:25.617] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:166:0)
[10:49:25.653] Build status: STARTED
[10:49:25.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:167:0) after 6m28s
[10:55:53.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:167:0)
[10:55:53.718] Build status: STARTED
[10:55:53.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:168:0) after 3m15s
[10:59:08.758] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:168:0)
[10:59:08.791] Build status: STARTED
[10:59:08.791] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:169:0) after 4m22s
[11:03:31.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:169:0)
[11:03:31.110] Build status: STARTED
[11:03:31.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:170:0) after 1m31s
[11:05:02.132] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:170:0)
[11:05:02.164] Build status: STARTED
[11:05:02.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:171:0) after 4m1s
[11:09:03.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:171:0)
[11:09:03.284] Build status: STARTED
[11:09:03.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:172:0) after 6m20s
[11:15:23.517] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:172:0)
[11:15:23.556] Build status: STARTED
[11:15:23.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:173:0) after 9m0s
[11:24:23.587] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:173:0)
[11:24:23.638] Build status: STARTED
[11:24:23.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:174:0) after 5m1s
[11:29:24.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:174:0)
[11:29:24.943] Build status: STARTED
[11:29:24.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:175:0) after 4m30s
[11:33:54.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:175:0)
[11:33:55.053] Build status: STARTED
[11:33:55.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:176:0) after 9m22s
[11:43:17.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:176:0)
[11:43:17.175] Build status: STARTED
[11:43:17.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:177:0) after 5m33s
[11:48:50.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:177:0)
[11:48:50.262] Build status: STARTED
[11:48:50.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:178:0) after 4m39s
[11:53:29.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:178:0)
[11:53:29.318] Build status: STARTED
[11:53:29.318] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:179:0) after 1m40s
[11:55:09.554] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:179:0)
[11:55:09.591] Build status: STARTED
[11:55:09.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:180:0) after 3m25s
[11:58:34.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:180:0)
[11:58:34.761] Build status: STARTED
[11:58:34.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:181:0) after 9m35s
[12:08:09.871] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:181:0)
[12:08:09.902] Build status: STARTED
[12:08:09.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:182:0) after 5m2s
[12:13:11.931] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:182:0)
[12:13:11.963] Build status: STARTED
[12:13:11.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:183:0) after 6m33s
[12:19:45.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:183:0)
[12:19:45.053] Build status: STARTED
[12:19:45.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:184:0) after 3m45s
[12:23:30.084] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:184:0)
[12:23:30.117] Build status: STARTED
[12:23:30.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:185:0) after 9m11s
[12:32:41.143] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:185:0)
[12:32:41.177] Build status: STARTED
[12:32:41.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:186:0) after 9m43s
[12:42:24.265] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:186:0)
[12:42:24.297] Build status: STARTED
[12:42:24.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:187:0) after 3m57s
[12:46:21.427] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:187:0)
[12:46:21.457] Build status: STARTED
[12:46:21.457] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:188:0) after 9m51s
[12:56:12.790] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:188:0)
[12:56:12.826] Build status: STARTED
[12:56:12.826] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:189:0) after 4m39s
[13:00:51.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:189:0)
[13:00:52.021] Build status: STARTED
[13:00:52.021] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:190:0) after 2m42s
[13:03:34.161] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:190:0)
[13:03:34.216] Build status: STARTED
[13:03:34.216] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:191:0) after 7m22s
[13:10:56.300] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:191:0)
[13:10:56.344] Build status: STARTED
[13:10:56.344] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:192:0) after 8m53s
[13:19:49.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:192:0)
[13:19:49.453] Build status: STARTED
[13:19:49.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:193:0) after 2m29s
[13:22:18.495] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:193:0)
[13:22:18.535] Build status: STARTED
[13:22:18.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:194:0) after 6m28s
[13:28:46.671] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:194:0)
[13:28:46.706] Build status: STARTED
[13:28:46.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:195:0) after 2m43s
[13:31:29.895] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:195:0)
[13:31:29.932] Build status: STARTED
[13:31:29.932] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:196:0) after 3m21s
[13:34:50.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:196:0)
[13:34:50.980] Build status: STARTED
[13:34:50.980] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:197:0) after 5m26s
[13:40:17.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:197:0)
[13:40:17.081] Build status: STARTED
[13:40:17.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:198:0) after 4m40s
[13:44:57.138] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:198:0)
[13:44:57.173] Build status: STARTED
[13:44:57.173] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:199:0) after 9m17s
[13:54:14.201] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:199:0)
[13:54:14.233] Build status: STARTED
[13:54:14.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:200:0) after 2m27s
[13:56:41.256] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:200:0)
[13:56:41.292] Build status: STARTED
[13:56:41.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:201:0) after 7m29s
[14:04:10.487] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:201:0)
[14:04:10.518] Build status: STARTED
[14:04:10.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:202:0) after 8m43s
[14:12:53.668] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:202:0)
[14:12:53.701] Build status: STARTED
[14:12:53.701] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:203:0) after 4m31s
[14:17:24.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:203:0)
[14:17:24.980] Build status: STARTED
[14:17:24.980] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:204:0) after 4m13s
[14:21:38.383] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:204:0)
[14:21:38.414] Build status: STARTED
[14:21:38.414] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:205:0) after 5m58s
[14:27:36.437] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:205:0)
[14:27:36.462] Build status: STARTED
[14:27:36.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:206:0) after 8m55s
[14:36:31.575] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:206:0)
[14:36:31.609] Build status: STARTED
[14:36:31.609] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:207:0) after 3m34s
[14:40:05.612] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:207:0)
[14:40:05.684] Build status: STARTED
[14:40:05.684] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:208:0) after 8m47s
[14:48:52.878] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:208:0)
[14:48:52.910] Build status: STARTED
[14:48:52.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:209:0) after 9m53s
[14:58:46.303] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:209:0)
[14:58:46.344] Build status: STARTED
[14:58:46.344] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:210:0) after 1m34s
[15:00:20.379] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:210:0)
[15:00:20.419] Build status: STARTED
[15:00:20.419] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:211:0) after 1m16s
[15:01:36.496] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:211:0)
[15:01:36.527] Build status: STARTED
[15:01:36.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:212:0) after 4m29s
[15:06:05.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:212:0)
[15:06:05.586] Build status: STARTED
[15:06:05.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:213:0) after 2m54s
[15:08:59.632] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:213:0)
[15:08:59.667] Build status: STARTED
[15:08:59.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:214:0) after 5m21s
[15:14:20.896] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:214:0)
[15:14:20.941] Build status: STARTED
[15:14:20.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:215:0) after 2m34s
[15:16:55.323] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:215:0)
[15:16:55.359] Build status: STARTED
[15:16:55.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:216:0) after 9m15s
[15:26:10.767] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:216:0)
[15:26:10.857] Build status: STARTED
[15:26:10.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:217:0) after 9m41s
[15:35:51.879] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:217:0)
[15:35:51.906] Build status: STARTED
[15:35:51.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:218:0) after 6m10s
[15:42:02.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:218:0)
[15:42:02.073] Build status: STARTED
[15:42:02.073] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:219:0) after 3m10s
[15:45:12.237] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:219:0)
[15:45:12.273] Build status: STARTED
[15:45:12.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:220:0) after 2m50s
[15:48:02.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:220:0)
[15:48:02.393] Build status: STARTED
[15:48:02.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:221:0) after 9m6s
[15:57:08.507] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:221:0)
[15:57:08.536] Build status: STARTED
[15:57:08.536] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:222:0) after 9m48s
[16:06:56.674] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:222:0)
[16:06:56.718] Build status: STARTED
[16:06:56.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:223:0) after 5m38s
[16:12:35.025] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:223:0)
[16:12:35.055] Build status: STARTED
[16:12:35.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:224:0) after 4m19s
[16:16:54.198] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:224:0)
[16:16:54.298] Build status: STARTED
[16:16:54.298] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:225:0) after 5m46s
[16:22:40.322] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:225:0)
[16:22:40.359] Build status: STARTED
[16:22:40.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:226:0) after 1m58s
[16:24:38.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:226:0)
[16:24:38.538] Build status: STARTED
[16:24:38.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:227:0) after 4m22s
[16:29:00.745] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:227:0)
[16:29:00.875] Build status: STARTED
[16:29:00.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:228:0) after 5m51s
[16:34:52.059] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:228:0)
[16:34:52.097] Build status: STARTED
[16:34:52.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:229:0) after 7m54s
[16:42:46.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:229:0)
[16:42:46.161] Build status: STARTED
[16:42:46.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:230:0) after 1m49s
[16:44:35.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:230:0)
[16:44:35.277] Build status: STARTED
[16:44:35.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:231:0) after 8m26s
[16:53:01.405] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:231:0)
[16:53:01.442] Build status: STARTED
[16:53:01.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:232:0) after 5m5s
[16:58:06.470] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:232:0)
[16:58:06.529] Build status: STARTED
[16:58:06.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:233:0) after 4m29s
[17:02:35.768] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:233:0)
[17:02:35.867] Build status: STARTED
[17:02:35.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:234:0) after 9m20s
[17:11:55.863] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:234:0)
[17:11:55.910] Build status: STARTED
[17:11:55.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:235:0) after 7m27s
[17:19:22.933] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:235:0)
[17:19:22.961] Build status: STARTED
[17:19:22.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:236:0) after 7m14s
[17:26:37.025] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:236:0)
[17:26:37.086] Build status: STARTED
[17:26:37.086] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:237:0) after 3m22s
[17:29:59.285] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:237:0)
[17:29:59.319] Build status: STARTED
[17:29:59.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:238:0) after 5m23s
[17:35:22.392] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:238:0)
[17:35:22.426] Build status: STARTED
[17:35:22.426] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:239:0) after 1m27s
[17:36:49.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:239:0)
[17:36:49.497] Build status: STARTED
[17:36:49.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:240:0) after 5m0s
[17:41:49.575] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:240:0)
[17:41:49.610] Build status: STARTED
[17:41:49.610] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:241:0) after 9m16s
[17:51:05.616] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:241:0)
[17:51:05.650] Build status: STARTED
[17:51:05.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:242:0) after 1m33s
[17:52:38.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:242:0)
[17:52:38.739] Build status: STARTED
[17:52:38.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:243:0) after 7m46s
[18:00:24.773] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:243:0)
[18:00:24.849] Build status: STARTED
[18:00:24.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:244:0) after 2m55s
[18:03:19.873] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:244:0)
[18:03:19.903] Build status: STARTED
[18:03:19.903] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:245:0) after 9m39s
[18:12:59.011] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:245:0)
[18:12:59.096] Build status: STARTED
[18:12:59.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:246:0) after 7m17s
[18:20:16.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:246:0)
[18:20:16.168] Build status: STARTED
[18:20:16.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:247:0) after 6m56s
[18:27:12.241] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:247:0)
[18:27:12.281] Build status: STARTED
[18:27:12.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:248:0) after 7m23s
[18:34:35.405] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:248:0)
[18:34:35.485] Build status: STARTED
[18:34:35.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:249:0) after 4m33s
[18:39:08.655] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:249:0)
[18:39:08.690] Build status: STARTED
[18:39:08.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:250:0) after 8m46s
[18:47:54.896] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:250:0)
[18:47:54.929] Build status: STARTED
[18:47:54.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:251:0) after 3m18s
[18:51:12.992] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:251:0)
[18:51:13.031] Build status: STARTED
[18:51:13.031] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:252:0) after 1m4s
[18:52:17.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:252:0)
[18:52:17.096] Build status: STARTED
[18:52:17.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:253:0) after 6m3s
[18:58:20.243] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:253:0)
[18:58:20.334] Build status: STARTED
[18:58:20.334] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:254:0) after 9m14s
[19:07:34.359] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:254:0)
[19:07:34.400] Build status: STARTED
[19:07:34.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:255:0) after 8m15s
[19:15:49.634] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:255:0)
[19:15:49.668] Build status: STARTED
[19:15:49.668] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:256:0) after 6m21s
[19:22:10.918] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:256:0)
[19:22:11.262] Build status: STARTED
[19:22:11.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:257:0) after 9m33s
[19:31:44.288] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:257:0)
[19:31:44.326] Build status: STARTED
[19:31:44.326] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:258:0) after 1m2s
[19:32:46.353] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:258:0)
[19:32:46.482] Build status: STARTED
[19:32:46.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:259:0) after 3m44s
[19:36:30.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:259:0)
[19:36:30.743] Build status: STARTED
[19:36:30.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:260:0) after 4m37s
[19:41:07.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:260:0)
[19:41:07.820] Build status: STARTED
[19:41:07.820] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:261:0) after 5m41s
[19:46:48.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:261:0)
[19:46:48.873] Build status: STARTED
[19:46:48.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:262:0) after 1m39s
[19:48:28.141] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:262:0)
[19:48:28.185] Build status: STARTED
[19:48:28.185] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8997077008878781712:263:0) after 7m38s
[19:50:20.717] Received PubSub notification, asking Buildbucket for the build status
[19:50:20.753] Build:
{
"id": "8831646946961293409",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 2180,
"createdBy": "project:r8",
"createTime": "2021-11-02T19:42:37.323408159Z",
"startTime": "2021-11-03T07:50:04.096272Z",
"endTime": "2021-11-03T19:50:18.077171Z",
"updateTime": "2021-11-03T19:50:18.811524Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "8c510fab0fc7bc78f1b861353b957df7bd8e5d5a",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:50:20.754] Invocation finished in 24h7m44.6425857s with status FAILED