[20:21:12.413] New invocation is queued and will start shortly
[20:21:12.413] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:21:13.489] Starting the invocation (attempt 1)
[20:21:13.521] Ignoring gitiles_ref tag without the buildset tag
[20:21:13.521] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:21:13.521] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:21:13.521] Buildbucket request:
{
"requestId": "8851847642929168160",
"builder": {
"project": "infra",
"bucket": "cron",
"builder": "Build From Tarball"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851847642929168160",
"job": "infra/Build From Tarball",
"triggers": [
{
"buildbucket": {
"properties": {
"version": "146.0.7680.152"
},
"tags": [
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
},
"id": "064249bf-4462-4a09-b060-722cee944b22",
"title": "publish_tarball/0",
"url": "https://cr-buildbucket.appspot.com/build/8686950530600421633"
}
]
},
"version": "146.0.7680.152"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851847642929168160"
},
{
"key": "scheduler_job_id",
"value": "infra/Build From Tarball"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "publish_tarball"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:21:13.960] Scheduled build:
{
"id": "8686417581020918913",
"builder": {
"project": "infra",
"bucket": "cron",
"builder": "Build From Tarball"
},
"createdBy": "project:infra",
"createTime": "2026-03-24T20:21:13.608262623Z",
"updateTime": "2026-03-24T20:21:13.608262623Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[20:21:13.960] Task URL: https://cr-buildbucket.appspot.com/build/8686417581020918913
[20:21:13.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:2:0) after 2m21s
[20:21:14.910] Received PubSub notification, asking Buildbucket for the build status
[20:21:16.241] Build status: SCHEDULED
[20:23:34.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:2:0)
[20:23:34.998] Build status: SCHEDULED
[20:23:34.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:4:0) after 8m30s
[20:27:49.670] Received PubSub notification, asking Buildbucket for the build status
[20:27:49.769] Build status: STARTED
[20:32:05.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:4:0)
[20:32:05.170] Build status: STARTED
[20:32:05.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:6:0) after 3m52s
[20:35:57.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:6:0)
[20:35:57.287] Build status: STARTED
[20:35:57.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:7:0) after 5m17s
[20:41:14.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:7:0)
[20:41:14.326] Build status: STARTED
[20:41:14.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:8:0) after 8m40s
[20:49:54.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:8:0)
[20:49:54.364] Build status: STARTED
[20:49:54.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:9:0) after 9m2s
[20:58:56.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:9:0)
[20:58:56.394] Build status: STARTED
[20:58:56.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:10:0) after 2m35s
[21:01:31.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:10:0)
[21:01:31.489] Build status: STARTED
[21:01:31.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:11:0) after 5m40s
[21:07:11.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:11:0)
[21:07:11.618] Build status: STARTED
[21:07:11.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:12:0) after 3m2s
[21:10:13.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:12:0)
[21:10:13.696] Build status: STARTED
[21:10:13.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:13:0) after 1m31s
[21:11:44.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:13:0)
[21:11:44.735] Build status: STARTED
[21:11:44.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:14:0) after 6m39s
[21:18:23.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:14:0)
[21:18:23.747] Build status: STARTED
[21:18:23.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:15:0) after 3m55s
[21:22:18.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:15:0)
[21:22:18.826] Build status: STARTED
[21:22:18.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:16:0) after 9m5s
[21:31:23.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:16:0)
[21:31:23.877] Build status: STARTED
[21:31:23.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:17:0) after 7m12s
[21:38:36.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:17:0)
[21:38:36.070] Build status: STARTED
[21:38:36.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:18:0) after 2m16s
[21:40:52.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:18:0)
[21:40:52.133] Build status: STARTED
[21:40:52.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:19:0) after 6m59s
[21:47:51.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:19:0)
[21:47:51.318] Build status: STARTED
[21:47:51.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:20:0) after 5m51s
[21:53:42.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:20:0)
[21:53:42.348] Build status: STARTED
[21:53:42.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:21:0) after 7m52s
[22:01:34.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:21:0)
[22:01:34.416] Build status: STARTED
[22:01:34.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:22:0) after 4m20s
[22:05:54.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:22:0)
[22:05:54.459] Build status: STARTED
[22:05:54.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:23:0) after 1m2s
[22:06:56.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:23:0)
[22:06:56.494] Build status: STARTED
[22:06:56.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:24:0) after 4m4s
[22:11:00.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:24:0)
[22:11:00.638] Build status: STARTED
[22:11:00.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:25:0) after 1m12s
[22:12:12.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:25:0)
[22:12:12.672] Build status: STARTED
[22:12:12.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:26:0) after 2m47s
[22:14:59.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:26:0)
[22:14:59.780] Build status: STARTED
[22:14:59.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:27:0) after 2m22s
[22:17:21.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:27:0)
[22:17:21.880] Build status: STARTED
[22:17:21.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:28:0) after 6m34s
[22:23:55.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:28:0)
[22:23:55.911] Build status: STARTED
[22:23:55.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:29:0) after 2m39s
[22:26:34.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:29:0)
[22:26:35.022] Build status: STARTED
[22:26:35.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:30:0) after 9m46s
[22:36:21.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:30:0)
[22:36:21.058] Build status: STARTED
[22:36:21.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:31:0) after 5m12s
[22:41:33.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:31:0)
[22:41:33.208] Build status: STARTED
[22:41:33.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:32:0) after 2m34s
[22:44:07.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:32:0)
[22:44:07.379] Build status: STARTED
[22:44:07.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:33:0) after 1m45s
[22:45:52.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:33:0)
[22:45:52.441] Build status: STARTED
[22:45:52.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:34:0) after 1m32s
[22:47:24.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:34:0)
[22:47:24.516] Build status: STARTED
[22:47:24.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:35:0) after 4m10s
[22:51:34.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:35:0)
[22:51:34.619] Build status: STARTED
[22:51:34.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:36:0) after 9m12s
[23:00:46.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:36:0)
[23:00:46.662] Build status: STARTED
[23:00:46.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:37:0) after 1m1s
[23:01:47.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:37:0)
[23:01:47.670] Build status: STARTED
[23:01:47.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:38:0) after 9m57s
[23:11:44.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:38:0)
[23:11:44.715] Build status: STARTED
[23:11:44.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:39:0) after 8m40s
[23:20:24.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:39:0)
[23:20:24.796] Build status: STARTED
[23:20:24.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:40:0) after 6m54s
[23:27:18.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:40:0)
[23:27:18.807] Build status: STARTED
[23:27:18.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:41:0) after 1m34s
[23:28:52.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:41:0)
[23:28:52.986] Build status: STARTED
[23:28:52.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:42:0) after 9m6s
[23:37:59.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:42:0)
[23:37:59.113] Build status: STARTED
[23:37:59.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:43:0) after 2m56s
[23:40:55.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:43:0)
[23:40:55.199] Build status: STARTED
[23:40:55.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:44:0) after 7m5s
[23:48:00.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:44:0)
[23:48:00.312] Build status: STARTED
[23:48:00.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:45:0) after 3m56s
[23:51:56.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:45:0)
[23:51:56.429] Build status: STARTED
[23:51:56.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:46:0) after 8m24s
[00:00:20.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:46:0)
[00:00:20.492] Build status: STARTED
[00:00:20.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:47:0) after 9m11s
[00:09:31.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:47:0)
[00:09:31.513] Build status: STARTED
[00:09:31.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:48:0) after 1m46s
[00:11:17.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:48:0)
[00:11:17.663] Build status: STARTED
[00:11:17.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:49:0) after 2m37s
[00:13:54.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:49:0)
[00:13:54.923] Build status: STARTED
[00:13:54.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:50:0) after 7m26s
[00:21:21.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:50:0)
[00:21:21.137] Build status: STARTED
[00:21:21.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:51:0) after 1m59s
[00:23:20.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:51:0)
[00:23:20.246] Build status: STARTED
[00:23:20.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:52:0) after 5m19s
[00:28:39.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:52:0)
[00:28:39.329] Build status: STARTED
[00:28:39.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:53:0) after 3m55s
[00:32:34.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:53:0)
[00:32:34.592] Build status: STARTED
[00:32:34.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:54:0) after 5m5s
[00:37:39.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:54:0)
[00:37:39.631] Build status: STARTED
[00:37:39.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:55:0) after 1m37s
[00:39:16.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:55:0)
[00:39:16.796] Build status: STARTED
[00:39:16.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:56:0) after 4m21s
[00:43:37.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:56:0)
[00:43:38.041] Build status: STARTED
[00:43:38.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:57:0) after 6m12s
[00:49:50.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:57:0)
[00:49:50.323] Build status: STARTED
[00:49:50.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:58:0) after 5m12s
[00:55:02.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:58:0)
[00:55:02.493] Build status: STARTED
[00:55:02.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:59:0) after 8m25s
[01:03:27.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:59:0)
[01:03:27.622] Build status: STARTED
[01:03:27.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:60:0) after 6m26s
[01:09:53.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:60:0)
[01:09:53.672] Build status: STARTED
[01:09:53.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:61:0) after 3m13s
[01:13:06.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:61:0)
[01:13:06.805] Build status: STARTED
[01:13:06.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:62:0) after 7m17s
[01:20:23.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:62:0)
[01:20:23.993] Build status: STARTED
[01:20:23.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:63:0) after 1m25s
[01:21:49.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:63:0)
[01:21:49.065] Build status: STARTED
[01:21:49.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:64:0) after 7m44s
[01:29:33.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:64:0)
[01:29:33.193] Build status: STARTED
[01:29:33.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:65:0) after 2m46s
[01:32:19.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:65:0)
[01:32:19.367] Build status: STARTED
[01:32:19.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:66:0) after 4m13s
[01:36:32.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:66:0)
[01:36:32.397] Build status: STARTED
[01:36:32.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:67:0) after 9m10s
[01:45:42.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:67:0)
[01:45:42.433] Build status: STARTED
[01:45:42.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:68:0) after 1m33s
[01:47:15.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:68:0)
[01:47:15.627] Build status: STARTED
[01:47:15.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:69:0) after 8m2s
[01:55:17.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:69:0)
[01:55:17.642] Build status: STARTED
[01:55:17.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:70:0) after 5m2s
[02:00:19.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:70:0)
[02:00:19.796] Build status: STARTED
[02:00:19.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:71:0) after 6m42s
[02:07:01.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:71:0)
[02:07:01.842] Build status: STARTED
[02:07:01.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:72:0) after 1m8s
[02:08:09.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:72:0)
[02:08:09.913] Build status: STARTED
[02:08:09.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:73:0) after 4m55s
[02:13:04.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:73:0)
[02:13:05.180] Build status: STARTED
[02:13:05.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:74:0) after 1m46s
[02:14:51.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:74:0)
[02:14:51.234] Build status: STARTED
[02:14:51.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:75:0) after 4m12s
[02:19:03.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:75:0)
[02:19:03.341] Build status: STARTED
[02:19:03.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:76:0) after 7m49s
[02:26:52.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:76:0)
[02:26:52.525] Build status: STARTED
[02:26:52.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:77:0) after 4m14s
[02:31:06.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:77:0)
[02:31:06.599] Build status: STARTED
[02:31:06.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:78:0) after 4m26s
[02:35:32.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:78:0)
[02:35:32.700] Build status: STARTED
[02:35:32.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:79:0) after 9m19s
[02:44:51.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:79:0)
[02:44:51.801] Build status: STARTED
[02:44:51.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:80:0) after 6m28s
[02:51:19.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:80:0)
[02:51:19.839] Build status: STARTED
[02:51:19.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:81:0) after 6m21s
[02:57:40.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:81:0)
[02:57:40.893] Build status: STARTED
[02:57:40.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:82:0) after 6m40s
[03:04:20.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:82:0)
[03:04:21.011] Build status: STARTED
[03:04:21.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:83:0) after 5m43s
[03:10:04.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:83:0)
[03:10:04.190] Build status: STARTED
[03:10:04.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:84:0) after 2m21s
[03:12:25.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:84:0)
[03:12:25.263] Build status: STARTED
[03:12:25.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:85:0) after 6m50s
[03:19:15.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:85:0)
[03:19:15.465] Build status: STARTED
[03:19:15.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:86:0) after 3m23s
[03:22:38.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:86:0)
[03:22:38.497] Build status: STARTED
[03:22:38.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:87:0) after 6m20s
[03:28:58.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:87:0)
[03:28:58.628] Build status: STARTED
[03:28:58.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:88:0) after 1m5s
[03:30:03.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:88:0)
[03:30:03.690] Build status: STARTED
[03:30:03.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:89:0) after 8m1s
[03:38:04.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:89:0)
[03:38:04.703] Build status: STARTED
[03:38:04.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:90:0) after 1m16s
[03:39:20.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:90:0)
[03:39:20.790] Build status: STARTED
[03:39:20.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:91:0) after 2m54s
[03:42:14.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:91:0)
[03:42:14.873] Build status: STARTED
[03:42:14.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:92:0) after 4m28s
[03:46:42.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:92:0)
[03:46:42.904] Build status: STARTED
[03:46:42.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:8851847642929168160:93:0) after 6m57s
[03:48:20.638] Received PubSub notification, asking Buildbucket for the build status
[03:48:20.652] Build:
{
"id": "8686417581020918913",
"builder": {
"project": "infra",
"bucket": "cron",
"builder": "Build From Tarball"
},
"createdBy": "project:infra",
"createTime": "2026-03-24T20:21:13.608262623Z",
"startTime": "2026-03-24T20:27:49.458385306Z",
"endTime": "2026-03-25T03:48:20.446773836Z",
"updateTime": "2026-03-25T03:48:20.446773836Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[03:48:20.652] Invocation finished in 7h27m8.247691238s with status SUCCEEDED