[14:33:39.087] New invocation is queued and will start shortly
[14:33:40.171] Starting the invocation (attempt 1)
[14:33:40.204] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/7e9f27d00ac29910611667e8627918d27b93a150"
[14:33:40.204] Popped gitiles commit info from properties and tags
[14:33:40.204] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:33:40.204] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:33:40.208] Buildbucket request:
{
"requestId": "8938480209103929360",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8938480209103929360",
"job": "r8/linux-internal",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "e04d305fe2a6d63999f6d32c08d5cfb689ac8818"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@e04d305fe2a6d63999f6d32c08d5cfb689ac8818",
"title": "e04d305fe2a6d63999f6d32c08d5cfb689ac8818",
"url": "https://r8.googlesource.com/r8/+/e04d305fe2a6d63999f6d32c08d5cfb689ac8818"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "f4ac56574039c88adb0e07f099bf3dc404e75ce0"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@f4ac56574039c88adb0e07f099bf3dc404e75ce0",
"title": "f4ac56574039c88adb0e07f099bf3dc404e75ce0",
"url": "https://r8.googlesource.com/r8/+/f4ac56574039c88adb0e07f099bf3dc404e75ce0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "40db6da88aa1e7220b93212334fcad49db12bf44"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@40db6da88aa1e7220b93212334fcad49db12bf44",
"title": "40db6da88aa1e7220b93212334fcad49db12bf44",
"url": "https://r8.googlesource.com/r8/+/40db6da88aa1e7220b93212334fcad49db12bf44"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "64b7373c51ff1f4b5983d3ba1eec45b9093f246c"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@64b7373c51ff1f4b5983d3ba1eec45b9093f246c",
"title": "64b7373c51ff1f4b5983d3ba1eec45b9093f246c",
"url": "https://r8.googlesource.com/r8/+/64b7373c51ff1f4b5983d3ba1eec45b9093f246c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "be718741bad86b301132e1b72e7bff7ead70b841"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@be718741bad86b301132e1b72e7bff7ead70b841",
"title": "be718741bad86b301132e1b72e7bff7ead70b841",
"url": "https://r8.googlesource.com/r8/+/be718741bad86b301132e1b72e7bff7ead70b841"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "73273de40deb115b8c3ca992ac305409c4861d3a"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@73273de40deb115b8c3ca992ac305409c4861d3a",
"title": "73273de40deb115b8c3ca992ac305409c4861d3a",
"url": "https://r8.googlesource.com/r8/+/73273de40deb115b8c3ca992ac305409c4861d3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "f857ed80450219e92b17eb7152a18d8477653ed8"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@f857ed80450219e92b17eb7152a18d8477653ed8",
"title": "f857ed80450219e92b17eb7152a18d8477653ed8",
"url": "https://r8.googlesource.com/r8/+/f857ed80450219e92b17eb7152a18d8477653ed8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "13918da1b4b5864507a08b9a8a1fa4592a4eaf13"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@13918da1b4b5864507a08b9a8a1fa4592a4eaf13",
"title": "13918da1b4b5864507a08b9a8a1fa4592a4eaf13",
"url": "https://r8.googlesource.com/r8/+/13918da1b4b5864507a08b9a8a1fa4592a4eaf13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "5cbe19ee74c39112578bef2ada4b1dc9d5e795d1"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@5cbe19ee74c39112578bef2ada4b1dc9d5e795d1",
"title": "5cbe19ee74c39112578bef2ada4b1dc9d5e795d1",
"url": "https://r8.googlesource.com/r8/+/5cbe19ee74c39112578bef2ada4b1dc9d5e795d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "18021f50bf2661a1c1aa6312004b3da2ef107ca7"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@18021f50bf2661a1c1aa6312004b3da2ef107ca7",
"title": "18021f50bf2661a1c1aa6312004b3da2ef107ca7",
"url": "https://r8.googlesource.com/r8/+/18021f50bf2661a1c1aa6312004b3da2ef107ca7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "ae077a205717fb7a8f635ee100acde7c8f659a2f"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@ae077a205717fb7a8f635ee100acde7c8f659a2f",
"title": "ae077a205717fb7a8f635ee100acde7c8f659a2f",
"url": "https://r8.googlesource.com/r8/+/ae077a205717fb7a8f635ee100acde7c8f659a2f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "5d325b1d464760f2b08d23c73f70c01438fb669d"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@5d325b1d464760f2b08d23c73f70c01438fb669d",
"title": "5d325b1d464760f2b08d23c73f70c01438fb669d",
"url": "https://r8.googlesource.com/r8/+/5d325b1d464760f2b08d23c73f70c01438fb669d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "77d2796a258b75c340ac3f65eeab3e3186925055"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@77d2796a258b75c340ac3f65eeab3e3186925055",
"title": "77d2796a258b75c340ac3f65eeab3e3186925055",
"url": "https://r8.googlesource.com/r8/+/77d2796a258b75c340ac3f65eeab3e3186925055"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "7c7c3741f3b0ea3254bbf7857643a56bdcb3d61b"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@7c7c3741f3b0ea3254bbf7857643a56bdcb3d61b",
"title": "7c7c3741f3b0ea3254bbf7857643a56bdcb3d61b",
"url": "https://r8.googlesource.com/r8/+/7c7c3741f3b0ea3254bbf7857643a56bdcb3d61b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "b3adc4745f8a7e08e36260e4dd85322e2eeb810b"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@b3adc4745f8a7e08e36260e4dd85322e2eeb810b",
"title": "b3adc4745f8a7e08e36260e4dd85322e2eeb810b",
"url": "https://r8.googlesource.com/r8/+/b3adc4745f8a7e08e36260e4dd85322e2eeb810b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "654005985639d5673eb637cf1b582f842dfd70db"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@654005985639d5673eb637cf1b582f842dfd70db",
"title": "654005985639d5673eb637cf1b582f842dfd70db",
"url": "https://r8.googlesource.com/r8/+/654005985639d5673eb637cf1b582f842dfd70db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://r8.googlesource.com/r8",
"revision": "7e9f27d00ac29910611667e8627918d27b93a150"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/main@7e9f27d00ac29910611667e8627918d27b93a150",
"title": "7e9f27d00ac29910611667e8627918d27b93a150",
"url": "https://r8.googlesource.com/r8/+/7e9f27d00ac29910611667e8627918d27b93a150"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "7e9f27d00ac29910611667e8627918d27b93a150",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8938480209103929360"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-internal"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:33:41.116] Scheduled build:
{
"id": "8773050147097762785",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 3394,
"createdBy": "project:r8",
"createTime": "2023-08-11T14:33:40.376571757Z",
"updateTime": "2023-08-11T14:33:40.376571757Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "7e9f27d00ac29910611667e8627918d27b93a150",
"ref": "refs/heads/main"
}
}
}
[14:33:41.117] Task URL: https://cr-buildbucket.appspot.com/build/8773050147097762785
[14:33:41.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:2:0) after 7m13s
[14:33:41.940] Received PubSub notification, asking Buildbucket for the build status
[14:33:41.970] Build status: SCHEDULED
[14:40:54.160] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:2:0)
[14:40:54.254] Build status: SCHEDULED
[14:40:54.254] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:4:0) after 2m59s
[14:43:53.595] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:4:0)
[14:43:53.614] Build status: SCHEDULED
[14:43:53.614] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:5:0) after 5m4s
[14:48:57.632] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:5:0)
[14:48:57.663] Build status: SCHEDULED
[14:48:57.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:6:0) after 9m29s
[14:58:27.038] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:6:0)
[14:58:27.059] Build status: SCHEDULED
[14:58:27.060] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:7:0) after 8m40s
[15:07:07.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:7:0)
[15:07:07.122] Build status: SCHEDULED
[15:07:07.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:8:0) after 3m46s
[15:10:53.154] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:8:0)
[15:10:53.179] Build status: SCHEDULED
[15:10:53.179] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:9:0) after 9m34s
[15:20:27.244] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:9:0)
[15:20:27.265] Build status: SCHEDULED
[15:20:27.265] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:10:0) after 3m52s
[15:24:19.403] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:10:0)
[15:24:19.424] Build status: SCHEDULED
[15:24:19.424] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:11:0) after 3m1s
[15:27:20.625] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:11:0)
[15:27:20.696] Build status: SCHEDULED
[15:27:20.696] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:12:0) after 1m20s
[15:28:40.801] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:12:0)
[15:28:40.825] Build status: SCHEDULED
[15:28:40.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:13:0) after 3m51s
[15:32:31.935] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:13:0)
[15:32:31.956] Build status: SCHEDULED
[15:32:31.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:14:0) after 9m57s
[15:42:29.654] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:14:0)
[15:42:29.675] Build status: SCHEDULED
[15:42:29.675] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:15:0) after 2m59s
[15:45:28.746] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:15:0)
[15:45:28.765] Build status: SCHEDULED
[15:45:28.765] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:16:0) after 9m31s
[15:54:59.796] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:16:0)
[15:54:59.822] Build status: SCHEDULED
[15:54:59.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:17:0) after 1m39s
[15:56:38.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:17:0)
[15:56:38.910] Build status: SCHEDULED
[15:56:38.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:18:0) after 2m16s
[15:58:54.942] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:18:0)
[15:58:55.060] Build status: SCHEDULED
[15:58:55.060] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:19:0) after 6m14s
[16:05:09.076] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:19:0)
[16:05:09.105] Build status: SCHEDULED
[16:05:09.105] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:20:0) after 4m12s
[16:09:21.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:20:0)
[16:09:21.150] Build status: SCHEDULED
[16:09:21.150] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:21:0) after 2m58s
[16:12:19.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:21:0)
[16:12:19.324] Build status: SCHEDULED
[16:12:19.324] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:22:0) after 6m40s
[16:18:59.713] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:22:0)
[16:18:59.736] Build status: SCHEDULED
[16:18:59.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:23:0) after 3m56s
[16:22:55.814] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:23:0)
[16:22:55.934] Build status: SCHEDULED
[16:22:55.934] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:24:0) after 6m36s
[16:29:32.030] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:24:0)
[16:29:32.057] Build status: SCHEDULED
[16:29:32.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:25:0) after 3m35s
[16:33:07.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:25:0)
[16:33:07.275] Build status: SCHEDULED
[16:33:07.275] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:26:0) after 9m29s
[16:42:36.381] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:26:0)
[16:42:36.401] Build status: SCHEDULED
[16:42:36.401] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:27:0) after 7m46s
[16:50:22.630] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:27:0)
[16:50:22.654] Build status: SCHEDULED
[16:50:22.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:28:0) after 1m32s
[16:51:54.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:28:0)
[16:51:54.697] Build status: SCHEDULED
[16:51:54.697] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:29:0) after 4m2s
[16:55:56.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:29:0)
[16:55:56.747] Build status: SCHEDULED
[16:55:56.747] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:30:0) after 7m47s
[17:03:43.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:30:0)
[17:03:43.885] Build status: SCHEDULED
[17:03:43.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:31:0) after 9m56s
[17:13:39.910] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:31:0)
[17:13:39.927] Build status: SCHEDULED
[17:13:39.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:32:0) after 1m27s
[17:15:07.000] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:32:0)
[17:15:07.024] Build status: SCHEDULED
[17:15:07.024] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:33:0) after 8m4s
[17:23:11.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:33:0)
[17:23:11.071] Build status: SCHEDULED
[17:23:11.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:34:0) after 8m17s
[17:31:28.894] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:34:0)
[17:31:28.916] Build status: SCHEDULED
[17:31:28.916] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:35:0) after 8m54s
[17:40:22.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:35:0)
[17:40:23.017] Build status: SCHEDULED
[17:40:23.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:36:0) after 9m18s
[17:49:41.037] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:36:0)
[17:49:41.057] Build status: SCHEDULED
[17:49:41.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:37:0) after 1m11s
[17:50:52.076] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:37:0)
[17:50:52.106] Build status: SCHEDULED
[17:50:52.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:38:0) after 8m0s
[17:58:52.126] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:38:0)
[17:58:52.161] Build status: SCHEDULED
[17:58:52.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:39:0) after 5m1s
[18:03:53.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:39:0)
[18:03:53.230] Build status: SCHEDULED
[18:03:53.230] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:40:0) after 9m27s
[18:13:20.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:40:0)
[18:13:20.331] Build status: SCHEDULED
[18:13:20.331] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:41:0) after 9m38s
[18:22:58.934] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:41:0)
[18:22:58.956] Build status: SCHEDULED
[18:22:58.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:42:0) after 7m20s
[18:30:19.194] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:42:0)
[18:30:19.228] Build status: SCHEDULED
[18:30:19.228] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:43:0) after 7m2s
[18:37:21.381] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:43:0)
[18:37:21.407] Build status: SCHEDULED
[18:37:21.408] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:44:0) after 3m53s
[18:41:14.440] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:44:0)
[18:41:14.460] Build status: SCHEDULED
[18:41:14.461] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:45:0) after 2m19s
[18:43:33.493] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:45:0)
[18:43:33.517] Build status: SCHEDULED
[18:43:33.517] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:46:0) after 2m27s
[18:46:00.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:46:0)
[18:46:00.558] Build status: SCHEDULED
[18:46:00.558] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:47:0) after 4m58s
[18:50:58.579] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:47:0)
[18:50:58.643] Build status: SCHEDULED
[18:50:58.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:48:0) after 9m38s
[19:00:36.711] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:48:0)
[19:00:36.733] Build status: SCHEDULED
[19:00:36.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:49:0) after 6m7s
[19:06:43.759] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:49:0)
[19:06:43.781] Build status: SCHEDULED
[19:06:43.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:50:0) after 6m9s
[19:12:52.804] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:50:0)
[19:12:52.823] Build status: SCHEDULED
[19:12:52.823] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:51:0) after 9m35s
[19:22:27.857] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:51:0)
[19:22:27.879] Build status: SCHEDULED
[19:22:27.879] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:52:0) after 4m20s
[19:26:47.917] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:52:0)
[19:26:47.938] Build status: SCHEDULED
[19:26:47.938] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:53:0) after 4m2s
[19:30:49.956] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:53:0)
[19:30:49.988] Build status: SCHEDULED
[19:30:49.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:54:0) after 2m41s
[19:33:32.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:54:0)
[19:33:32.173] Build status: SCHEDULED
[19:33:32.173] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:55:0) after 3m26s
[19:36:58.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:55:0)
[19:36:58.280] Build status: SCHEDULED
[19:36:58.280] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:56:0) after 5m13s
[19:42:11.345] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:56:0)
[19:42:11.372] Build status: SCHEDULED
[19:42:11.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:57:0) after 9m41s
[19:51:52.594] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:57:0)
[19:51:52.651] Build status: SCHEDULED
[19:51:52.651] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:58:0) after 3m29s
[19:55:22.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:58:0)
[19:55:22.323] Build status: SCHEDULED
[19:55:22.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:59:0) after 6m13s
[20:01:35.368] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:59:0)
[20:01:35.396] Build status: SCHEDULED
[20:01:35.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:60:0) after 9m38s
[20:11:13.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:60:0)
[20:11:13.454] Build status: SCHEDULED
[20:11:13.454] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:61:0) after 2m58s
[20:14:11.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:61:0)
[20:14:11.543] Build status: SCHEDULED
[20:14:11.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:62:0) after 6m47s
[20:20:58.566] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:62:0)
[20:20:58.586] Build status: SCHEDULED
[20:20:58.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:63:0) after 5m14s
[20:26:12.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:63:0)
[20:26:12.728] Build status: SCHEDULED
[20:26:12.728] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:64:0) after 8m16s
[20:34:29.422] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:64:0)
[20:34:29.481] Build status: SCHEDULED
[20:34:29.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:65:0) after 6m14s
[20:40:43.568] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:65:0)
[20:40:43.592] Build status: SCHEDULED
[20:40:43.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:66:0) after 6m28s
[20:47:12.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:66:0)
[20:47:12.105] Build status: SCHEDULED
[20:47:12.105] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:67:0) after 9m27s
[20:56:39.273] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:67:0)
[20:56:39.317] Build status: SCHEDULED
[20:56:39.317] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:68:0) after 9m54s
[21:06:33.407] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:68:0)
[21:06:33.426] Build status: SCHEDULED
[21:06:33.426] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:69:0) after 7m42s
[21:14:16.135] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:69:0)
[21:14:16.274] Build status: SCHEDULED
[21:14:16.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:70:0) after 4m6s
[21:18:22.310] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:70:0)
[21:18:22.367] Build status: SCHEDULED
[21:18:22.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:71:0) after 9m5s
[21:27:27.486] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:71:0)
[21:27:27.502] Build status: SCHEDULED
[21:27:27.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:72:0) after 9m54s
[21:37:21.524] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:72:0)
[21:37:21.619] Build status: SCHEDULED
[21:37:21.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:73:0) after 8m49s
[21:46:10.715] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:73:0)
[21:46:10.769] Build status: SCHEDULED
[21:46:10.769] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:74:0) after 6m10s
[21:52:20.789] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:74:0)
[21:52:20.905] Build status: SCHEDULED
[21:52:20.905] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:75:0) after 5m58s
[21:58:18.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:75:0)
[21:58:18.967] Build status: SCHEDULED
[21:58:18.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:76:0) after 5m7s
[22:03:26.296] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:76:0)
[22:03:26.352] Build status: SCHEDULED
[22:03:26.352] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:77:0) after 5m51s
[22:09:17.521] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:77:0)
[22:09:17.946] Build status: SCHEDULED
[22:09:17.946] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:78:0) after 6m28s
[22:15:45.971] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:78:0)
[22:15:46.002] Build status: SCHEDULED
[22:15:46.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:79:0) after 5m53s
[22:21:39.080] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:79:0)
[22:21:39.099] Build status: SCHEDULED
[22:21:39.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:80:0) after 2m30s
[22:24:09.194] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:80:0)
[22:24:09.213] Build status: SCHEDULED
[22:24:09.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:81:0) after 1m42s
[22:25:51.233] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:81:0)
[22:25:51.294] Build status: SCHEDULED
[22:25:51.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:82:0) after 3m26s
[22:29:17.312] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:82:0)
[22:29:17.341] Build status: SCHEDULED
[22:29:17.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:83:0) after 9m29s
[22:38:46.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:83:0)
[22:38:46.381] Build status: SCHEDULED
[22:38:46.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:84:0) after 5m0s
[22:43:46.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:84:0)
[22:43:46.430] Build status: SCHEDULED
[22:43:46.430] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:85:0) after 8m40s
[22:52:26.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:85:0)
[22:52:26.546] Build status: SCHEDULED
[22:52:26.546] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:86:0) after 8m50s
[23:01:16.520] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:86:0)
[23:01:16.632] Build status: SCHEDULED
[23:01:16.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:87:0) after 1m35s
[23:02:51.776] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:87:0)
[23:02:51.863] Build status: SCHEDULED
[23:02:51.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:88:0) after 3m51s
[23:06:42.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:88:0)
[23:06:43.162] Build status: SCHEDULED
[23:06:43.162] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:89:0) after 9m53s
[23:16:36.266] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:89:0)
[23:16:36.304] Build status: SCHEDULED
[23:16:36.304] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:90:0) after 4m45s
[23:21:21.325] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:90:0)
[23:21:21.431] Build status: SCHEDULED
[23:21:21.431] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:91:0) after 9m34s
[23:30:56.067] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:91:0)
[23:30:56.086] Build status: SCHEDULED
[23:30:56.086] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:92:0) after 7m35s
[23:38:31.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:92:0)
[23:38:31.152] Build status: SCHEDULED
[23:38:31.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:93:0) after 1m7s
[23:39:38.180] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:93:0)
[23:39:38.219] Build status: SCHEDULED
[23:39:38.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:94:0) after 5m6s
[23:44:44.281] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:94:0)
[23:44:44.418] Build status: SCHEDULED
[23:44:44.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:95:0) after 4m49s
[23:49:33.438] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:95:0)
[23:49:33.469] Build status: SCHEDULED
[23:49:33.469] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:96:0) after 4m57s
[23:54:30.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:96:0)
[23:54:30.622] Build status: SCHEDULED
[23:54:30.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:97:0) after 4m7s
[23:58:37.741] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:97:0)
[23:58:37.765] Build status: SCHEDULED
[23:58:37.765] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:98:0) after 8m54s
[00:07:31.854] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:98:0)
[00:07:31.892] Build status: SCHEDULED
[00:07:31.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:99:0) after 3m11s
[00:10:43.146] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:99:0)
[00:10:43.169] Build status: SCHEDULED
[00:10:43.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:100:0) after 4m50s
[00:15:33.283] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:100:0)
[00:15:33.318] Build status: SCHEDULED
[00:15:33.318] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:101:0) after 3m45s
[00:19:18.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:101:0)
[00:19:18.516] Build status: SCHEDULED
[00:19:18.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:102:0) after 3m48s
[00:23:06.735] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:102:0)
[00:23:06.758] Build status: SCHEDULED
[00:23:06.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:103:0) after 6m31s
[00:29:37.939] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:103:0)
[00:29:37.984] Build status: SCHEDULED
[00:29:37.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:104:0) after 6m55s
[00:36:33.569] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:104:0)
[00:36:33.589] Build status: SCHEDULED
[00:36:33.589] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:105:0) after 8m43s
[00:45:17.040] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:105:0)
[00:45:17.054] Build status: SCHEDULED
[00:45:17.054] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:106:0) after 1m36s
[00:46:54.020] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:106:0)
[00:46:54.038] Build status: SCHEDULED
[00:46:54.039] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:107:0) after 4m41s
[00:51:35.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:107:0)
[00:51:35.055] Build status: SCHEDULED
[00:51:35.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:108:0) after 7m13s
[00:58:48.059] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:108:0)
[00:58:48.110] Build status: SCHEDULED
[00:58:48.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:109:0) after 8m50s
[01:07:38.307] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:109:0)
[01:07:38.333] Build status: SCHEDULED
[01:07:38.333] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:110:0) after 5m27s
[01:13:05.351] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:110:0)
[01:13:05.375] Build status: SCHEDULED
[01:13:05.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:111:0) after 6m7s
[01:19:12.448] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:111:0)
[01:19:12.532] Build status: SCHEDULED
[01:19:12.532] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:112:0) after 7m17s
[01:26:29.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:112:0)
[01:26:29.631] Build status: SCHEDULED
[01:26:29.631] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:113:0) after 2m9s
[01:28:38.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:113:0)
[01:28:38.745] Build status: SCHEDULED
[01:28:38.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:114:0) after 9m33s
[01:38:11.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:114:0)
[01:38:11.779] Build status: SCHEDULED
[01:38:11.779] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:115:0) after 9m54s
[01:48:05.757] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:115:0)
[01:48:05.786] Build status: SCHEDULED
[01:48:05.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:116:0) after 8m28s
[01:56:33.907] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:116:0)
[01:56:33.940] Build status: SCHEDULED
[01:56:33.940] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:117:0) after 5m30s
[02:02:04.047] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:117:0)
[02:02:04.150] Build status: SCHEDULED
[02:02:04.150] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:118:0) after 8m39s
[02:10:43.291] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:118:0)
[02:10:43.308] Build status: SCHEDULED
[02:10:43.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:119:0) after 8m18s
[02:19:01.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:119:0)
[02:19:01.629] Build status: SCHEDULED
[02:19:01.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:120:0) after 8m33s
[02:27:34.649] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:120:0)
[02:27:34.679] Build status: SCHEDULED
[02:27:34.679] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:121:0) after 8m28s
[02:36:02.778] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:121:0)
[02:36:02.797] Build status: SCHEDULED
[02:36:02.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:122:0) after 9m47s
[02:41:10.277] Received PubSub notification, asking Buildbucket for the build status
[02:41:10.297] Build status: STARTED
[02:45:50.003] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:122:0)
[02:45:50.029] Build status: STARTED
[02:45:50.029] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:124:0) after 3m53s
[02:49:43.050] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:124:0)
[02:49:43.079] Build status: STARTED
[02:49:43.079] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:125:0) after 7m21s
[02:57:04.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:125:0)
[02:57:04.126] Build status: STARTED
[02:57:04.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:126:0) after 9m23s
[03:06:27.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:126:0)
[03:06:27.220] Build status: STARTED
[03:06:27.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:127:0) after 5m11s
[03:11:38.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:127:0)
[03:11:38.293] Build status: STARTED
[03:11:38.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:128:0) after 7m18s
[03:18:56.464] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:128:0)
[03:18:56.482] Build status: STARTED
[03:18:56.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:129:0) after 5m36s
[03:24:32.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:129:0)
[03:24:32.542] Build status: STARTED
[03:24:32.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:130:0) after 7m18s
[03:31:50.670] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:130:0)
[03:31:50.702] Build status: STARTED
[03:31:50.702] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:131:0) after 9m52s
[03:41:42.702] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:131:0)
[03:41:42.736] Build status: STARTED
[03:41:42.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:132:0) after 6m16s
[03:47:58.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:132:0)
[03:47:58.794] Build status: STARTED
[03:47:58.794] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:133:0) after 1m24s
[03:49:22.809] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:133:0)
[03:49:22.827] Build status: STARTED
[03:49:22.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:134:0) after 1m8s
[03:50:30.842] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:134:0)
[03:50:30.883] Build status: STARTED
[03:50:30.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:135:0) after 2m3s
[03:52:33.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:135:0)
[03:52:33.982] Build status: STARTED
[03:52:33.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:136:0) after 1m49s
[03:54:23.005] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:136:0)
[03:54:23.028] Build status: STARTED
[03:54:23.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:137:0) after 4m47s
[03:59:10.112] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:137:0)
[03:59:10.160] Build status: STARTED
[03:59:10.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:138:0) after 1m33s
[04:00:43.315] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:138:0)
[04:00:43.381] Build status: STARTED
[04:00:43.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:139:0) after 7m8s
[04:07:51.519] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:139:0)
[04:07:51.543] Build status: STARTED
[04:07:51.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:140:0) after 9m49s
[04:17:40.589] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:140:0)
[04:17:40.616] Build status: STARTED
[04:17:40.616] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:141:0) after 6m57s
[04:24:37.834] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:141:0)
[04:24:37.862] Build status: STARTED
[04:24:37.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:142:0) after 2m23s
[04:27:01.108] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:142:0)
[04:27:01.136] Build status: STARTED
[04:27:01.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:143:0) after 3m24s
[04:30:25.197] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:143:0)
[04:30:25.229] Build status: STARTED
[04:30:25.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:144:0) after 3m15s
[04:33:40.254] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:144:0)
[04:33:40.281] Build status: STARTED
[04:33:40.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:145:0) after 4m33s
[04:38:13.312] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:145:0)
[04:38:13.335] Build status: STARTED
[04:38:13.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:146:0) after 7m2s
[04:45:15.497] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:146:0)
[04:45:15.530] Build status: STARTED
[04:45:15.530] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:147:0) after 6m33s
[04:51:48.608] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:147:0)
[04:51:48.635] Build status: STARTED
[04:51:48.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:148:0) after 7m49s
[04:59:37.621] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:148:0)
[04:59:37.638] Build status: STARTED
[04:59:37.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:149:0) after 5m21s
[05:04:58.647] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:149:0)
[05:04:58.667] Build status: STARTED
[05:04:58.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:150:0) after 2m45s
[05:07:43.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:150:0)
[05:07:43.836] Build status: STARTED
[05:07:43.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:151:0) after 9m2s
[05:16:45.855] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:151:0)
[05:16:45.886] Build status: STARTED
[05:16:45.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:152:0) after 9m21s
[05:26:07.036] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:152:0)
[05:26:07.109] Build status: STARTED
[05:26:07.109] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:153:0) after 5m8s
[05:31:16.503] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:153:0)
[05:31:16.667] Build status: STARTED
[05:31:16.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:154:0) after 1m9s
[05:32:25.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:154:0)
[05:32:25.723] Build status: STARTED
[05:32:25.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:155:0) after 9m44s
[05:42:09.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:155:0)
[05:42:09.775] Build status: STARTED
[05:42:09.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:156:0) after 5m32s
[05:47:41.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:156:0)
[05:47:41.848] Build status: STARTED
[05:47:41.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:157:0) after 2m7s
[05:49:49.070] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:157:0)
[05:49:49.099] Build status: STARTED
[05:49:49.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:158:0) after 7m35s
[05:57:24.114] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:158:0)
[05:57:24.239] Build status: STARTED
[05:57:24.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:159:0) after 7m44s
[06:05:08.369] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:159:0)
[06:05:08.412] Build status: STARTED
[06:05:08.412] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:160:0) after 9m33s
[06:14:41.499] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:160:0)
[06:14:41.520] Build status: STARTED
[06:14:41.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:161:0) after 9m34s
[06:24:15.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:161:0)
[06:24:15.759] Build status: STARTED
[06:24:15.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:162:0) after 7m49s
[06:32:04.779] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:162:0)
[06:32:04.804] Build status: STARTED
[06:32:04.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:163:0) after 5m57s
[06:38:02.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:163:0)
[06:38:02.039] Build status: STARTED
[06:38:02.039] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:164:0) after 1m50s
[06:39:52.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:164:0)
[06:39:52.078] Build status: STARTED
[06:39:52.078] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:165:0) after 2m44s
[06:42:36.325] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:165:0)
[06:42:36.361] Build status: STARTED
[06:42:36.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:166:0) after 1m36s
[06:44:12.624] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:166:0)
[06:44:12.689] Build status: STARTED
[06:44:12.689] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:167:0) after 7m44s
[06:51:56.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:167:0)
[06:51:56.758] Build status: STARTED
[06:51:56.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:168:0) after 1m46s
[06:53:42.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:168:0)
[06:53:42.810] Build status: STARTED
[06:53:42.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:169:0) after 8m16s
[07:01:59.042] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:169:0)
[07:01:59.073] Build status: STARTED
[07:01:59.073] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:170:0) after 9m8s
[07:11:07.096] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:170:0)
[07:11:07.118] Build status: STARTED
[07:11:07.118] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:171:0) after 6m5s
[07:17:12.146] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:171:0)
[07:17:12.229] Build status: STARTED
[07:17:12.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:172:0) after 9m14s
[07:26:26.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:172:0)
[07:26:26.284] Build status: STARTED
[07:26:26.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:173:0) after 5m16s
[07:31:42.307] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:173:0)
[07:31:42.339] Build status: STARTED
[07:31:42.339] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:174:0) after 9m27s
[07:41:09.364] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:174:0)
[07:41:09.440] Build status: STARTED
[07:41:09.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:175:0) after 2m15s
[07:43:24.739] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:175:0)
[07:43:24.762] Build status: STARTED
[07:43:24.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:176:0) after 6m3s
[07:49:27.781] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:176:0)
[07:49:27.802] Build status: STARTED
[07:49:27.802] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:177:0) after 6m35s
[07:56:02.947] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:177:0)
[07:56:02.985] Build status: STARTED
[07:56:02.985] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:178:0) after 6m40s
[08:02:43.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:178:0)
[08:02:43.457] Build status: STARTED
[08:02:43.457] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:179:0) after 8m5s
[08:10:48.478] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:179:0)
[08:10:48.498] Build status: STARTED
[08:10:48.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:180:0) after 2m51s
[08:13:39.719] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:180:0)
[08:13:39.753] Build status: STARTED
[08:13:39.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:181:0) after 1m35s
[08:15:14.873] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:181:0)
[08:15:14.896] Build status: STARTED
[08:15:14.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:182:0) after 3m29s
[08:18:44.868] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:182:0)
[08:18:44.906] Build status: STARTED
[08:18:44.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:183:0) after 2m28s
[08:21:12.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:183:0)
[08:21:12.964] Build status: STARTED
[08:21:12.964] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:184:0) after 2m15s
[08:23:27.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:184:0)
[08:23:28.011] Build status: STARTED
[08:23:28.011] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:185:0) after 5m25s
[08:28:53.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:185:0)
[08:28:53.059] Build status: STARTED
[08:28:53.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:186:0) after 5m57s
[08:34:51.562] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:186:0)
[08:34:51.658] Build status: STARTED
[08:34:51.658] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:187:0) after 4m14s
[08:39:05.677] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:187:0)
[08:39:05.697] Build status: STARTED
[08:39:05.697] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:188:0) after 2m3s
[08:41:08.923] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:188:0)
[08:41:08.954] Build status: STARTED
[08:41:08.954] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:189:0) after 4m40s
[08:45:49.171] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:189:0)
[08:45:49.191] Build status: STARTED
[08:45:49.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:190:0) after 4m28s
[08:50:17.436] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:190:0)
[08:50:17.538] Build status: STARTED
[08:50:17.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:191:0) after 9m59s
[09:00:16.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:191:0)
[09:00:16.731] Build status: STARTED
[09:00:16.731] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:192:0) after 1m43s
[09:02:00.284] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:192:0)
[09:02:00.314] Build status: STARTED
[09:02:00.314] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:193:0) after 8m38s
[09:10:38.506] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:193:0)
[09:10:38.520] Build status: STARTED
[09:10:38.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:194:0) after 4m15s
[09:14:53.542] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:194:0)
[09:14:53.561] Build status: STARTED
[09:14:53.561] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:195:0) after 2m2s
[09:16:55.729] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:195:0)
[09:16:55.767] Build status: STARTED
[09:16:55.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:196:0) after 3m45s
[09:20:40.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:196:0)
[09:20:40.786] Build status: STARTED
[09:20:40.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:197:0) after 9m9s
[09:29:50.015] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:197:0)
[09:29:50.096] Build status: STARTED
[09:29:50.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:198:0) after 9m20s
[09:39:10.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:198:0)
[09:39:10.144] Build status: STARTED
[09:39:10.144] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:199:0) after 3m22s
[09:42:32.176] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:199:0)
[09:42:32.205] Build status: STARTED
[09:42:32.205] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:200:0) after 2m1s
[09:44:33.715] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:200:0)
[09:44:33.752] Build status: STARTED
[09:44:33.752] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:201:0) after 2m2s
[09:46:36.018] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:201:0)
[09:46:36.053] Build status: STARTED
[09:46:36.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:202:0) after 8m9s
[09:54:45.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:202:0)
[09:54:45.093] Build status: STARTED
[09:54:45.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:203:0) after 1m42s
[09:56:27.112] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:203:0)
[09:56:27.138] Build status: STARTED
[09:56:27.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:204:0) after 7m28s
[10:03:55.176] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:204:0)
[10:03:55.201] Build status: STARTED
[10:03:55.201] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:205:0) after 7m1s
[10:10:56.240] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:205:0)
[10:10:56.273] Build status: STARTED
[10:10:56.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:206:0) after 6m35s
[10:17:31.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:206:0)
[10:17:31.321] Build status: STARTED
[10:17:31.321] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:207:0) after 9m43s
[10:27:14.487] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:207:0)
[10:27:14.519] Build status: STARTED
[10:27:14.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:208:0) after 5m23s
[10:32:37.616] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:208:0)
[10:32:37.638] Build status: STARTED
[10:32:37.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:209:0) after 3m18s
[10:35:56.012] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:209:0)
[10:35:56.043] Build status: STARTED
[10:35:56.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:210:0) after 2m46s
[10:38:42.066] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:210:0)
[10:38:42.091] Build status: STARTED
[10:38:42.091] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:211:0) after 4m51s
[10:43:33.144] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:211:0)
[10:43:33.237] Build status: STARTED
[10:43:33.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:212:0) after 7m48s
[10:51:21.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:212:0)
[10:51:21.923] Build status: STARTED
[10:51:21.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:213:0) after 8m9s
[10:59:30.933] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:213:0)
[10:59:30.983] Build status: STARTED
[10:59:30.983] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:214:0) after 6m1s
[11:05:32.404] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:214:0)
[11:05:32.436] Build status: STARTED
[11:05:32.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:215:0) after 3m29s
[11:09:01.454] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:215:0)
[11:09:01.478] Build status: STARTED
[11:09:01.478] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:216:0) after 5m18s
[11:14:19.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:216:0)
[11:14:19.662] Build status: STARTED
[11:14:19.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:217:0) after 5m58s
[11:20:17.880] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:217:0)
[11:20:17.902] Build status: STARTED
[11:20:17.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:218:0) after 2m20s
[11:22:37.924] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:218:0)
[11:22:37.959] Build status: STARTED
[11:22:37.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:219:0) after 4m24s
[11:27:02.227] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:219:0)
[11:27:02.269] Build status: STARTED
[11:27:02.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:220:0) after 9m37s
[11:36:39.258] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:220:0)
[11:36:39.278] Build status: STARTED
[11:36:39.278] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:221:0) after 3m35s
[11:40:14.321] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:221:0)
[11:40:14.479] Build status: STARTED
[11:40:14.479] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:222:0) after 6m2s
[11:46:16.605] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:222:0)
[11:46:16.642] Build status: STARTED
[11:46:16.642] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:223:0) after 1m21s
[11:47:37.664] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:223:0)
[11:47:37.692] Build status: STARTED
[11:47:37.692] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:224:0) after 8m19s
[11:55:56.722] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:224:0)
[11:55:56.805] Build status: STARTED
[11:55:56.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:225:0) after 7m33s
[12:03:29.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:225:0)
[12:03:30.038] Build status: STARTED
[12:03:30.038] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:226:0) after 2m23s
[12:05:53.148] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:226:0)
[12:05:53.181] Build status: STARTED
[12:05:53.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:227:0) after 9m17s
[12:15:10.401] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:227:0)
[12:15:10.450] Build status: STARTED
[12:15:10.450] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:228:0) after 3m22s
[12:18:32.517] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:228:0)
[12:18:32.608] Build status: STARTED
[12:18:32.608] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:229:0) after 9m27s
[12:27:59.649] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:229:0)
[12:27:59.678] Build status: STARTED
[12:27:59.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:230:0) after 3m29s
[12:31:28.711] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:230:0)
[12:31:28.730] Build status: STARTED
[12:31:28.730] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:231:0) after 7m17s
[12:38:46.155] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:231:0)
[12:38:46.187] Build status: STARTED
[12:38:46.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:232:0) after 3m18s
[12:42:04.630] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:232:0)
[12:42:04.685] Build status: STARTED
[12:42:04.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:233:0) after 7m46s
[12:49:50.703] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:233:0)
[12:49:50.786] Build status: STARTED
[12:49:50.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:234:0) after 3m24s
[12:53:14.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:234:0)
[12:53:14.952] Build status: STARTED
[12:53:14.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:235:0) after 6m3s
[12:59:17.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:235:0)
[12:59:17.990] Build status: STARTED
[12:59:17.990] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:236:0) after 3m36s
[13:02:54.122] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:236:0)
[13:02:54.161] Build status: STARTED
[13:02:54.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:237:0) after 7m44s
[13:10:38.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:237:0)
[13:10:38.273] Build status: STARTED
[13:10:38.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:238:0) after 6m56s
[13:17:34.404] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:238:0)
[13:17:34.424] Build status: STARTED
[13:17:34.424] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:239:0) after 1m44s
[13:19:18.540] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:239:0)
[13:19:18.574] Build status: STARTED
[13:19:18.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:240:0) after 4m37s
[13:23:55.711] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:240:0)
[13:23:55.732] Build status: STARTED
[13:23:55.732] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:241:0) after 7m18s
[13:31:13.986] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:241:0)
[13:31:14.085] Build status: STARTED
[13:31:14.085] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:242:0) after 1m2s
[13:32:16.115] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:242:0)
[13:32:16.179] Build status: STARTED
[13:32:16.179] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:243:0) after 2m29s
[13:34:45.353] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:243:0)
[13:34:45.398] Build status: STARTED
[13:34:45.398] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:244:0) after 1m24s
[13:36:09.563] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:244:0)
[13:36:09.673] Build status: STARTED
[13:36:09.673] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:245:0) after 6m3s
[13:42:12.712] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:245:0)
[13:42:12.743] Build status: STARTED
[13:42:12.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:246:0) after 2m41s
[13:44:53.772] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:246:0)
[13:44:53.827] Build status: STARTED
[13:44:53.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:247:0) after 3m33s
[13:48:26.805] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:247:0)
[13:48:26.837] Build status: STARTED
[13:48:26.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:248:0) after 6m7s
[13:54:33.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:248:0)
[13:54:33.896] Build status: STARTED
[13:54:33.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:249:0) after 3m54s
[13:58:27.924] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:249:0)
[13:58:27.947] Build status: STARTED
[13:58:27.947] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:250:0) after 6m44s
[14:05:12.155] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:250:0)
[14:05:12.189] Build status: STARTED
[14:05:12.189] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:251:0) after 8m4s
[14:13:16.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:251:0)
[14:13:16.237] Build status: STARTED
[14:13:16.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:252:0) after 9m3s
[14:22:19.293] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:252:0)
[14:22:19.368] Build status: STARTED
[14:22:19.368] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:253:0) after 2m28s
[14:24:47.400] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:253:0)
[14:24:47.420] Build status: STARTED
[14:24:47.420] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:254:0) after 6m45s
[14:31:32.464] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:254:0)
[14:31:32.631] Build status: STARTED
[14:31:32.631] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:255:0) after 1m29s
[14:33:01.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:255:0)
[14:33:01.688] Build status: STARTED
[14:33:01.688] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:256:0) after 4m47s
[14:37:48.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:256:0)
[14:37:48.733] Build status: STARTED
[14:37:48.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8938480209103929360:257:0) after 5m46s
[14:41:22.494] Received PubSub notification, asking Buildbucket for the build status
[14:41:22.523] Build:
{
"id": "8773050147097762785",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal"
},
"number": 3394,
"createdBy": "project:r8",
"createTime": "2023-08-11T14:33:40.376571757Z",
"startTime": "2023-08-12T02:41:09.304599Z",
"endTime": "2023-08-12T14:41:22.236639906Z",
"updateTime": "2023-08-12T14:41:22.236639906Z",
"status": "FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "7e9f27d00ac29910611667e8627918d27b93a150",
"ref": "refs/heads/main"
}
}
}
[14:41:22.523] Invocation finished in 24h7m43.442573938s with status FAILED