[22:27:10.722] New invocation is queued and will start shortly
[22:27:12.368] Starting the invocation (attempt 1)
[22:27:12.417] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e"
[22:27:12.417] Popped gitiles commit info from properties and tags
[22:27:12.417] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:27:12.418] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:27:12.418] Buildbucket request:
{
"requestId": "8976048158410979296",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8976048158410979296",
"job": "r8/linux-internal_release",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/3.3",
"repo": "https://r8.googlesource.com/r8",
"revision": "c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e"
},
"id": "https://r8.googlesource.com/r8/+/refs/heads/3.3@c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e",
"title": "c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e",
"url": "https://r8.googlesource.com/r8/+/c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e"
}
]
}
},
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e",
"ref": "refs/heads/3.3"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8976048158410979296"
},
{
"key": "scheduler_job_id",
"value": "r8/linux-internal_release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:27:12.915] Scheduled build:
{
"id": "8810618095886175873",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 684,
"createdBy": "project:r8",
"createTime": "2022-06-22T22:27:12.497141694Z",
"updateTime": "2022-06-22T22:27:12.497141694Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e",
"ref": "refs/heads/3.3"
}
}
}
[22:27:12.915] Task URL: https://cr-buildbucket.appspot.com/build/8810618095886175873
[22:27:12.915] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:2:0) after 9m48s
[22:37:01.797] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:2:0)
[22:37:01.836] Build status: SCHEDULED
[22:37:01.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:3:0) after 6m27s
[22:43:28.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:3:0)
[22:43:28.894] Build status: SCHEDULED
[22:43:28.894] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:4:0) after 4m15s
[22:47:43.910] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:4:0)
[22:47:43.943] Build status: SCHEDULED
[22:47:43.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:5:0) after 9m5s
[22:56:49.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:5:0)
[22:56:49.102] Build status: SCHEDULED
[22:56:49.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:6:0) after 1m21s
[22:58:10.333] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:6:0)
[22:58:10.381] Build status: SCHEDULED
[22:58:10.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:7:0) after 4m37s
[23:02:47.363] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:7:0)
[23:02:47.393] Build status: SCHEDULED
[23:02:47.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:8:0) after 7m35s
[23:10:22.409] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:8:0)
[23:10:22.445] Build status: SCHEDULED
[23:10:22.445] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:9:0) after 1m42s
[23:12:04.464] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:9:0)
[23:12:04.502] Build status: SCHEDULED
[23:12:04.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:10:0) after 7m6s
[23:19:10.496] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:10:0)
[23:19:10.564] Build status: SCHEDULED
[23:19:10.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:11:0) after 1m25s
[23:20:35.727] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:11:0)
[23:20:35.758] Build status: SCHEDULED
[23:20:35.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:12:0) after 5m42s
[23:26:17.776] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:12:0)
[23:26:17.808] Build status: SCHEDULED
[23:26:17.808] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:13:0) after 2m44s
[23:29:02.325] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:13:0)
[23:29:02.359] Build status: SCHEDULED
[23:29:02.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:14:0) after 7m9s
[23:36:11.493] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:14:0)
[23:36:11.521] Build status: SCHEDULED
[23:36:11.521] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:15:0) after 5m3s
[23:41:14.545] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:15:0)
[23:41:14.641] Build status: SCHEDULED
[23:41:14.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:16:0) after 3m17s
[23:44:31.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:16:0)
[23:44:31.753] Build status: SCHEDULED
[23:44:31.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:17:0) after 3m27s
[23:47:58.872] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:17:0)
[23:47:58.906] Build status: SCHEDULED
[23:47:58.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:18:0) after 9m46s
[23:57:44.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:18:0)
[23:57:44.957] Build status: SCHEDULED
[23:57:44.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:19:0) after 8m32s
[00:06:17.221] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:19:0)
[00:06:17.269] Build status: SCHEDULED
[00:06:17.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:20:0) after 1m34s
[00:07:51.287] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:20:0)
[00:07:51.311] Build status: SCHEDULED
[00:07:51.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:21:0) after 3m36s
[00:11:27.463] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:21:0)
[00:11:27.567] Build status: SCHEDULED
[00:11:27.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:22:0) after 2m22s
[00:13:49.647] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:22:0)
[00:13:49.669] Build status: SCHEDULED
[00:13:49.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:23:0) after 4m55s
[00:18:45.492] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:23:0)
[00:18:45.526] Build status: SCHEDULED
[00:18:45.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:24:0) after 9m58s
[00:28:43.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:24:0)
[00:28:43.692] Build status: SCHEDULED
[00:28:43.692] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:25:0) after 1m54s
[00:30:37.912] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:25:0)
[00:30:37.942] Build status: SCHEDULED
[00:30:37.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:26:0) after 5m43s
[00:36:20.961] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:26:0)
[00:36:21.014] Build status: SCHEDULED
[00:36:21.014] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:27:0) after 7m30s
[00:43:51.138] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:27:0)
[00:43:51.158] Build status: SCHEDULED
[00:43:51.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:28:0) after 4m0s
[00:47:51.178] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:28:0)
[00:47:51.203] Build status: SCHEDULED
[00:47:51.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:29:0) after 7m56s
[00:55:47.341] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:29:0)
[00:55:47.371] Build status: SCHEDULED
[00:55:47.371] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:30:0) after 8m19s
[01:04:06.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:30:0)
[01:04:06.564] Build status: SCHEDULED
[01:04:06.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:31:0) after 1m38s
[01:05:44.781] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:31:0)
[01:05:45.158] Build status: SCHEDULED
[01:05:45.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:32:0) after 6m24s
[01:12:09.216] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:32:0)
[01:12:09.248] Build status: SCHEDULED
[01:12:09.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:33:0) after 8m18s
[01:20:27.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:33:0)
[01:20:27.367] Build status: SCHEDULED
[01:20:27.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:34:0) after 6m2s
[01:26:29.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:34:0)
[01:26:29.417] Build status: SCHEDULED
[01:26:29.417] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:35:0) after 8m40s
[01:35:09.447] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:35:0)
[01:35:09.486] Build status: SCHEDULED
[01:35:09.486] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:36:0) after 1m21s
[01:36:30.508] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:36:0)
[01:36:30.536] Build status: SCHEDULED
[01:36:30.536] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:37:0) after 5m33s
[01:42:03.725] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:37:0)
[01:42:03.767] Build status: SCHEDULED
[01:42:03.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:38:0) after 6m40s
[01:48:43.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:38:0)
[01:48:44.023] Build status: SCHEDULED
[01:48:44.023] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:39:0) after 1m55s
[01:50:39.326] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:39:0)
[01:50:39.361] Build status: SCHEDULED
[01:50:39.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:40:0) after 4m54s
[01:55:33.524] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:40:0)
[01:55:33.548] Build status: SCHEDULED
[01:55:33.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:41:0) after 4m37s
[02:00:10.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:41:0)
[02:00:10.638] Build status: SCHEDULED
[02:00:10.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:42:0) after 2m13s
[02:02:23.735] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:42:0)
[02:02:23.774] Build status: SCHEDULED
[02:02:23.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:43:0) after 9m47s
[02:12:10.929] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:43:0)
[02:12:10.952] Build status: SCHEDULED
[02:12:10.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:44:0) after 6m44s
[02:18:54.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:44:0)
[02:18:55.007] Build status: SCHEDULED
[02:18:55.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:45:0) after 7m39s
[02:26:34.027] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:45:0)
[02:26:34.073] Build status: SCHEDULED
[02:26:34.073] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:46:0) after 9m48s
[02:36:22.096] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:46:0)
[02:36:22.135] Build status: SCHEDULED
[02:36:22.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:47:0) after 9m44s
[02:46:06.314] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:47:0)
[02:46:06.348] Build status: SCHEDULED
[02:46:06.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:48:0) after 6m13s
[02:52:19.414] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:48:0)
[02:52:19.481] Build status: SCHEDULED
[02:52:19.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:49:0) after 1m10s
[02:53:29.543] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:49:0)
[02:53:29.765] Build status: SCHEDULED
[02:53:29.765] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:50:0) after 1m14s
[02:54:43.834] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:50:0)
[02:54:43.854] Build status: SCHEDULED
[02:54:43.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:51:0) after 1m49s
[02:56:32.876] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:51:0)
[02:56:32.906] Build status: SCHEDULED
[02:56:32.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:52:0) after 9m37s
[03:06:09.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:52:0)
[03:06:10.001] Build status: SCHEDULED
[03:06:10.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:53:0) after 6m32s
[03:12:42.038] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:53:0)
[03:12:42.073] Build status: SCHEDULED
[03:12:42.073] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:54:0) after 5m33s
[03:18:15.267] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:54:0)
[03:18:15.372] Build status: SCHEDULED
[03:18:15.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:55:0) after 9m49s
[03:28:04.395] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:55:0)
[03:28:04.468] Build status: SCHEDULED
[03:28:04.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:56:0) after 4m59s
[03:33:03.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:56:0)
[03:33:03.531] Build status: SCHEDULED
[03:33:03.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:57:0) after 1m37s
[03:34:40.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:57:0)
[03:34:40.591] Build status: SCHEDULED
[03:34:40.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:58:0) after 5m3s
[03:39:43.688] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:58:0)
[03:39:43.720] Build status: SCHEDULED
[03:39:43.721] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:59:0) after 9m39s
[03:49:22.849] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:59:0)
[03:49:22.929] Build status: SCHEDULED
[03:49:22.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:60:0) after 6m23s
[03:55:46.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:60:0)
[03:55:46.198] Build status: SCHEDULED
[03:55:46.198] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:61:0) after 7m45s
[04:03:31.180] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:61:0)
[04:03:31.212] Build status: SCHEDULED
[04:03:31.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:62:0) after 6m59s
[04:10:30.241] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:62:0)
[04:10:30.261] Build status: SCHEDULED
[04:10:30.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:63:0) after 9m8s
[04:19:38.415] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:63:0)
[04:19:38.467] Build status: SCHEDULED
[04:19:38.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:64:0) after 2m25s
[04:22:03.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:64:0)
[04:22:03.550] Build status: SCHEDULED
[04:22:03.550] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:65:0) after 8m43s
[04:30:46.598] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:65:0)
[04:30:46.650] Build status: SCHEDULED
[04:30:46.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:66:0) after 3m34s
[04:34:20.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:66:0)
[04:34:20.755] Build status: SCHEDULED
[04:34:20.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:67:0) after 4m43s
[04:39:03.798] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:67:0)
[04:39:03.829] Build status: SCHEDULED
[04:39:03.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:68:0) after 4m36s
[04:43:39.962] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:68:0)
[04:43:40.071] Build status: SCHEDULED
[04:43:40.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:69:0) after 2m48s
[04:46:28.212] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:69:0)
[04:46:28.244] Build status: SCHEDULED
[04:46:28.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:70:0) after 9m4s
[04:55:32.299] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:70:0)
[04:55:32.335] Build status: SCHEDULED
[04:55:32.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:71:0) after 6m23s
[05:01:55.457] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:71:0)
[05:01:55.491] Build status: SCHEDULED
[05:01:55.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:72:0) after 7m30s
[05:09:25.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:72:0)
[05:09:25.560] Build status: SCHEDULED
[05:09:25.560] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:73:0) after 1m10s
[05:10:35.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:73:0)
[05:10:35.695] Build status: SCHEDULED
[05:10:35.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:74:0) after 5m2s
[05:15:37.772] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:74:0)
[05:15:37.809] Build status: SCHEDULED
[05:15:37.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:75:0) after 1m39s
[05:17:16.833] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:75:0)
[05:17:16.867] Build status: SCHEDULED
[05:17:16.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:76:0) after 1m4s
[05:18:20.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:76:0)
[05:18:21.035] Build status: SCHEDULED
[05:18:21.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:77:0) after 8m59s
[05:27:20.056] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:77:0)
[05:27:20.087] Build status: SCHEDULED
[05:27:20.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:78:0) after 2m21s
[05:29:41.174] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:78:0)
[05:29:41.242] Build status: SCHEDULED
[05:29:41.242] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:79:0) after 6m26s
[05:36:07.301] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:79:0)
[05:36:07.335] Build status: SCHEDULED
[05:36:07.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:80:0) after 4m30s
[05:40:37.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:80:0)
[05:40:37.571] Build status: SCHEDULED
[05:40:37.571] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:81:0) after 5m39s
[05:46:16.891] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:81:0)
[05:46:16.921] Build status: SCHEDULED
[05:46:16.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:82:0) after 6m1s
[05:52:17.979] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:82:0)
[05:52:18.100] Build status: SCHEDULED
[05:52:18.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:83:0) after 3m26s
[05:55:44.217] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:83:0)
[05:55:44.251] Build status: SCHEDULED
[05:55:44.251] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:84:0) after 1m37s
[05:57:21.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:84:0)
[05:57:21.597] Build status: SCHEDULED
[05:57:21.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:85:0) after 1m22s
[05:58:43.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:85:0)
[05:58:43.878] Build status: SCHEDULED
[05:58:43.878] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:86:0) after 3m1s
[06:01:45.420] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:86:0)
[06:01:45.467] Build status: SCHEDULED
[06:01:45.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:87:0) after 8m50s
[06:10:36.148] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:87:0)
[06:10:36.184] Build status: SCHEDULED
[06:10:36.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:88:0) after 5m19s
[06:15:55.206] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:88:0)
[06:15:55.243] Build status: SCHEDULED
[06:15:55.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:89:0) after 1m38s
[06:17:33.290] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:89:0)
[06:17:33.344] Build status: SCHEDULED
[06:17:33.344] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:90:0) after 3m56s
[06:21:29.395] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:90:0)
[06:21:29.459] Build status: SCHEDULED
[06:21:29.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:91:0) after 5m50s
[06:27:19.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:91:0)
[06:27:19.798] Build status: SCHEDULED
[06:27:19.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:92:0) after 3m51s
[06:31:10.920] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:92:0)
[06:31:10.965] Build status: SCHEDULED
[06:31:10.965] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:93:0) after 5m22s
[06:36:32.985] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:93:0)
[06:36:33.024] Build status: SCHEDULED
[06:36:33.024] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:94:0) after 7m35s
[06:44:08.307] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:94:0)
[06:44:08.339] Build status: SCHEDULED
[06:44:08.339] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:95:0) after 5m5s
[06:49:13.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:95:0)
[06:49:13.489] Build status: SCHEDULED
[06:49:13.489] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:96:0) after 4m47s
[06:54:00.699] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:96:0)
[06:54:00.753] Build status: SCHEDULED
[06:54:00.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:97:0) after 9m37s
[07:03:37.796] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:97:0)
[07:03:37.852] Build status: SCHEDULED
[07:03:37.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:98:0) after 3m16s
[07:06:53.897] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:98:0)
[07:06:53.956] Build status: SCHEDULED
[07:06:53.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:99:0) after 9m55s
[07:16:49.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:99:0)
[07:16:49.053] Build status: SCHEDULED
[07:16:49.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:100:0) after 2m36s
[07:19:25.318] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:100:0)
[07:19:25.351] Build status: SCHEDULED
[07:19:25.351] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:101:0) after 4m47s
[07:24:12.375] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:101:0)
[07:24:12.399] Build status: SCHEDULED
[07:24:12.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:102:0) after 7m28s
[07:31:40.458] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:102:0)
[07:31:40.491] Build status: SCHEDULED
[07:31:40.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:103:0) after 2m13s
[07:33:53.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:103:0)
[07:33:53.795] Build status: SCHEDULED
[07:33:53.795] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:104:0) after 7m14s
[07:41:07.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:104:0)
[07:41:07.809] Build status: SCHEDULED
[07:41:07.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:105:0) after 5m26s
[07:46:33.829] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:105:0)
[07:46:33.862] Build status: SCHEDULED
[07:46:33.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:106:0) after 6m2s
[07:52:36.109] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:106:0)
[07:52:36.143] Build status: SCHEDULED
[07:52:36.143] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:107:0) after 7m19s
[07:59:55.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:107:0)
[07:59:55.223] Build status: SCHEDULED
[07:59:55.223] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:108:0) after 3m27s
[08:03:22.355] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:108:0)
[08:03:22.432] Build status: SCHEDULED
[08:03:22.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:109:0) after 3m35s
[08:06:57.455] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:109:0)
[08:06:57.508] Build status: SCHEDULED
[08:06:57.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:110:0) after 6m39s
[08:13:36.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:110:0)
[08:13:36.585] Build status: SCHEDULED
[08:13:36.585] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:111:0) after 7m6s
[08:19:37.210] Received PubSub notification, asking Buildbucket for the build status
[08:19:37.254] Build status: STARTED
[08:20:42.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:111:0)
[08:20:42.815] Build status: STARTED
[08:20:42.815] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:113:0) after 4m8s
[08:24:50.963] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:113:0)
[08:24:51.015] Build status: STARTED
[08:24:51.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:114:0) after 5m52s
[08:30:43.044] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:114:0)
[08:30:43.080] Build status: STARTED
[08:30:43.080] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:115:0) after 2m41s
[08:33:24.227] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:115:0)
[08:33:24.277] Build status: STARTED
[08:33:24.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:116:0) after 1m42s
[08:35:06.269] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:116:0)
[08:35:06.299] Build status: STARTED
[08:35:06.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:117:0) after 7m54s
[08:43:00.349] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:117:0)
[08:43:00.390] Build status: STARTED
[08:43:00.390] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:118:0) after 2m51s
[08:45:51.486] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:118:0)
[08:45:51.526] Build status: STARTED
[08:45:51.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:119:0) after 7m30s
[08:53:21.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:119:0)
[08:53:21.655] Build status: STARTED
[08:53:21.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:120:0) after 5m8s
[08:58:29.873] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:120:0)
[08:58:29.906] Build status: STARTED
[08:58:29.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:121:0) after 5m5s
[09:03:34.937] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:121:0)
[09:03:34.967] Build status: STARTED
[09:03:34.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:122:0) after 9m3s
[09:12:37.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:122:0)
[09:12:38.021] Build status: STARTED
[09:12:38.021] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:123:0) after 8m22s
[09:21:00.158] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:123:0)
[09:21:00.227] Build status: STARTED
[09:21:00.227] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:124:0) after 2m28s
[09:23:28.373] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:124:0)
[09:23:28.436] Build status: STARTED
[09:23:28.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:125:0) after 8m32s
[09:32:00.555] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:125:0)
[09:32:00.588] Build status: STARTED
[09:32:00.588] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:126:0) after 7m52s
[09:39:52.630] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:126:0)
[09:39:52.663] Build status: STARTED
[09:39:52.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:127:0) after 3m15s
[09:43:07.822] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:127:0)
[09:43:07.857] Build status: STARTED
[09:43:07.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:128:0) after 6m21s
[09:49:28.878] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:128:0)
[09:49:28.908] Build status: STARTED
[09:49:28.908] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:129:0) after 8m58s
[09:58:27.140] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:129:0)
[09:58:27.174] Build status: STARTED
[09:58:27.174] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:130:0) after 8m26s
[10:06:53.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:130:0)
[10:06:53.232] Build status: STARTED
[10:06:53.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:131:0) after 5m55s
[10:12:48.459] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:131:0)
[10:12:48.491] Build status: STARTED
[10:12:48.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:132:0) after 3m34s
[10:16:22.515] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:132:0)
[10:16:22.596] Build status: STARTED
[10:16:22.596] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:133:0) after 1m35s
[10:17:57.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:133:0)
[10:17:57.735] Build status: STARTED
[10:17:57.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:134:0) after 5m58s
[10:23:55.881] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:134:0)
[10:23:55.921] Build status: STARTED
[10:23:55.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:135:0) after 8m24s
[10:32:19.942] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:135:0)
[10:32:19.985] Build status: STARTED
[10:32:19.985] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:136:0) after 7m22s
[10:39:42.002] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:136:0)
[10:39:42.034] Build status: STARTED
[10:39:42.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:137:0) after 4m1s
[10:43:43.082] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:137:0)
[10:43:43.143] Build status: STARTED
[10:43:43.144] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:138:0) after 6m8s
[10:49:51.166] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:138:0)
[10:49:51.239] Build status: STARTED
[10:49:51.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:139:0) after 8m27s
[10:58:18.307] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:139:0)
[10:58:18.385] Build status: STARTED
[10:58:18.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:140:0) after 8m31s
[11:06:49.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:140:0)
[11:06:49.686] Build status: STARTED
[11:06:49.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:141:0) after 2m11s
[11:09:01.142] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:141:0)
[11:09:01.178] Build status: STARTED
[11:09:01.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:142:0) after 6m29s
[11:15:30.199] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:142:0)
[11:15:30.252] Build status: STARTED
[11:15:30.252] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:143:0) after 6m55s
[11:22:25.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:143:0)
[11:22:25.485] Build status: STARTED
[11:22:25.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:144:0) after 2m5s
[11:24:30.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:144:0)
[11:24:30.544] Build status: STARTED
[11:24:30.544] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:145:0) after 2m8s
[11:26:38.565] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:145:0)
[11:26:38.603] Build status: STARTED
[11:26:38.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:146:0) after 8m44s
[11:35:22.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:146:0)
[11:35:22.810] Build status: STARTED
[11:35:22.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:147:0) after 7m16s
[11:42:38.911] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:147:0)
[11:42:38.944] Build status: STARTED
[11:42:38.944] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:148:0) after 1m37s
[11:44:15.975] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:148:0)
[11:44:16.112] Build status: STARTED
[11:44:16.112] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:149:0) after 1m59s
[11:46:15.134] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:149:0)
[11:46:15.175] Build status: STARTED
[11:46:15.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:150:0) after 3m9s
[11:49:24.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:150:0)
[11:49:24.302] Build status: STARTED
[11:49:24.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:151:0) after 7m3s
[11:56:27.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:151:0)
[11:56:27.366] Build status: STARTED
[11:56:27.366] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:152:0) after 4m5s
[12:00:32.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:152:0)
[12:00:32.497] Build status: STARTED
[12:00:32.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:153:0) after 5m47s
[12:06:19.520] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:153:0)
[12:06:19.553] Build status: STARTED
[12:06:19.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:154:0) after 5m22s
[12:11:41.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:154:0)
[12:11:41.630] Build status: STARTED
[12:11:41.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:155:0) after 9m9s
[12:20:50.664] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:155:0)
[12:20:50.749] Build status: STARTED
[12:20:50.749] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:156:0) after 5m4s
[12:25:54.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:156:0)
[12:25:54.862] Build status: STARTED
[12:25:54.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:157:0) after 3m12s
[12:29:06.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:157:0)
[12:29:07.050] Build status: STARTED
[12:29:07.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:158:0) after 6m14s
[12:35:21.072] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:158:0)
[12:35:21.117] Build status: STARTED
[12:35:21.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:159:0) after 6m23s
[12:41:44.277] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:159:0)
[12:41:44.319] Build status: STARTED
[12:41:44.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:160:0) after 6m18s
[12:48:02.440] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:160:0)
[12:48:02.475] Build status: STARTED
[12:48:02.475] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:161:0) after 4m23s
[12:52:25.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:161:0)
[12:52:25.549] Build status: STARTED
[12:52:25.549] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:162:0) after 8m23s
[13:00:48.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:162:0)
[13:00:48.625] Build status: STARTED
[13:00:48.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:163:0) after 5m24s
[13:06:12.691] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:163:0)
[13:06:12.727] Build status: STARTED
[13:06:12.727] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8976048158410979296:164:0) after 5m44s
[13:09:33.966] Received PubSub notification, asking Buildbucket for the build status
[13:09:34.015] Build:
{
"id": "8810618095886175873",
"builder": {
"project": "r8",
"bucket": "ci",
"builder": "linux-internal_release"
},
"number": 684,
"createdBy": "project:r8",
"createTime": "2022-06-22T22:27:12.497141694Z",
"startTime": "2022-06-23T08:19:36.569424743Z",
"endTime": "2022-06-23T13:09:33.543142128Z",
"updateTime": "2022-06-23T13:09:33.543142128Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "r8.googlesource.com",
"project": "r8",
"id": "c0e7efd5845505e01b1ee44fb6b5d2dcd1761f6e",
"ref": "refs/heads/3.3"
}
}
}
[13:09:34.015] Invocation finished in 14h42m23.309927206s with status SUCCEEDED