[10:32:15.600] New invocation is queued and will start shortly
[10:32:16.705] Starting the invocation (attempt 1)
[10:32:16.734] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109"
[10:32:16.734] Popped gitiles commit info from properties and tags
[10:32:16.734] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:32:16.735] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:32:16.736] Buildbucket request:
{
"requestId": "8850435144800244496",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8850435144800244496",
"job": "chromium-m148/win-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "df5cd92e26362587aad0b1c05beeb21cf40d86de"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@df5cd92e26362587aad0b1c05beeb21cf40d86de",
"title": "df5cd92e26362587aad0b1c05beeb21cf40d86de",
"url": "https://chromium.googlesource.com/chromium/src/+/df5cd92e26362587aad0b1c05beeb21cf40d86de"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "689ee613f55e75f50a9b05d2b1e4951bcdf45eac"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@689ee613f55e75f50a9b05d2b1e4951bcdf45eac",
"title": "689ee613f55e75f50a9b05d2b1e4951bcdf45eac",
"url": "https://chromium.googlesource.com/chromium/src/+/689ee613f55e75f50a9b05d2b1e4951bcdf45eac"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6f9a144e6a0b5d39f59a46a01644b460f9afbc1e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@6f9a144e6a0b5d39f59a46a01644b460f9afbc1e",
"title": "6f9a144e6a0b5d39f59a46a01644b460f9afbc1e",
"url": "https://chromium.googlesource.com/chromium/src/+/6f9a144e6a0b5d39f59a46a01644b460f9afbc1e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d92c68b91430f32a9695bdc3dadb1b208a176b9c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@d92c68b91430f32a9695bdc3dadb1b208a176b9c",
"title": "d92c68b91430f32a9695bdc3dadb1b208a176b9c",
"url": "https://chromium.googlesource.com/chromium/src/+/d92c68b91430f32a9695bdc3dadb1b208a176b9c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "63c101a0df044377079dfb13f184bb0710a442ae"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@63c101a0df044377079dfb13f184bb0710a442ae",
"title": "63c101a0df044377079dfb13f184bb0710a442ae",
"url": "https://chromium.googlesource.com/chromium/src/+/63c101a0df044377079dfb13f184bb0710a442ae"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5bdf2297fd02d60766388cc38e1d7a32fb5aac05"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5bdf2297fd02d60766388cc38e1d7a32fb5aac05",
"title": "5bdf2297fd02d60766388cc38e1d7a32fb5aac05",
"url": "https://chromium.googlesource.com/chromium/src/+/5bdf2297fd02d60766388cc38e1d7a32fb5aac05"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "957d35ca3d9fd0d5b736cb68f4101a46cbb306eb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@957d35ca3d9fd0d5b736cb68f4101a46cbb306eb",
"title": "957d35ca3d9fd0d5b736cb68f4101a46cbb306eb",
"url": "https://chromium.googlesource.com/chromium/src/+/957d35ca3d9fd0d5b736cb68f4101a46cbb306eb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "991f1e7e5e640991a6ec646c469d28ba8dfdcf15"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@991f1e7e5e640991a6ec646c469d28ba8dfdcf15",
"title": "991f1e7e5e640991a6ec646c469d28ba8dfdcf15",
"url": "https://chromium.googlesource.com/chromium/src/+/991f1e7e5e640991a6ec646c469d28ba8dfdcf15"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "edce4262c8b4b1abb5ee7d50531d66436b5efed3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@edce4262c8b4b1abb5ee7d50531d66436b5efed3",
"title": "edce4262c8b4b1abb5ee7d50531d66436b5efed3",
"url": "https://chromium.googlesource.com/chromium/src/+/edce4262c8b4b1abb5ee7d50531d66436b5efed3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cc455a2d067a2a5c2792de8a6269b2b9333619ae"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@cc455a2d067a2a5c2792de8a6269b2b9333619ae",
"title": "cc455a2d067a2a5c2792de8a6269b2b9333619ae",
"url": "https://chromium.googlesource.com/chromium/src/+/cc455a2d067a2a5c2792de8a6269b2b9333619ae"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b008867dd7d11e4bdee184f318d5209fcc33c41a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b008867dd7d11e4bdee184f318d5209fcc33c41a",
"title": "b008867dd7d11e4bdee184f318d5209fcc33c41a",
"url": "https://chromium.googlesource.com/chromium/src/+/b008867dd7d11e4bdee184f318d5209fcc33c41a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "02aefcb00ce376ca99072d5935b4eb2807a68a02"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@02aefcb00ce376ca99072d5935b4eb2807a68a02",
"title": "02aefcb00ce376ca99072d5935b4eb2807a68a02",
"url": "https://chromium.googlesource.com/chromium/src/+/02aefcb00ce376ca99072d5935b4eb2807a68a02"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9575b942bafb8281f40ab062b9854d282e8ee79b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@9575b942bafb8281f40ab062b9854d282e8ee79b",
"title": "9575b942bafb8281f40ab062b9854d282e8ee79b",
"url": "https://chromium.googlesource.com/chromium/src/+/9575b942bafb8281f40ab062b9854d282e8ee79b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "86507a8ce52aae70ae38313917632abe7bdc2297"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@86507a8ce52aae70ae38313917632abe7bdc2297",
"title": "86507a8ce52aae70ae38313917632abe7bdc2297",
"url": "https://chromium.googlesource.com/chromium/src/+/86507a8ce52aae70ae38313917632abe7bdc2297"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b72963daf8854443945aac52c3ace33b0161a855"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b72963daf8854443945aac52c3ace33b0161a855",
"title": "b72963daf8854443945aac52c3ace33b0161a855",
"url": "https://chromium.googlesource.com/chromium/src/+/b72963daf8854443945aac52c3ace33b0161a855"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109",
"title": "8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109",
"url": "https://chromium.googlesource.com/chromium/src/+/8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8850435144800244496"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:32:17.439] Scheduled build:
{
"id": "8685005082863228737",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-official"
},
"number": 14,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-09T10:32:16.823263060Z",
"updateTime": "2026-04-09T10:32:16.823263060Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109",
"ref": "refs/branch-heads/7778"
}
}
}
[10:32:17.439] Task URL: https://cr-buildbucket.appspot.com/build/8685005082863228737
[10:32:17.439] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:2:0) after 2m25s
[10:32:24.713] Received PubSub notification, asking Buildbucket for the build status
[10:32:24.748] Build status: SCHEDULED
[10:34:42.459] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:2:0)
[10:34:42.477] Build status: SCHEDULED
[10:34:42.477] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:4:0) after 2m4s
[10:36:46.492] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:4:0)
[10:36:46.514] Build status: SCHEDULED
[10:36:46.514] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:5:0) after 7m1s
[10:43:47.577] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:5:0)
[10:43:47.603] Build status: SCHEDULED
[10:43:47.603] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:6:0) after 3m23s
[10:47:10.637] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:6:0)
[10:47:10.657] Build status: SCHEDULED
[10:47:10.657] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:7:0) after 5m51s
[10:53:01.717] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:7:0)
[10:53:01.736] Build status: SCHEDULED
[10:53:01.736] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:8:0) after 6m54s
[10:59:55.856] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:8:0)
[10:59:55.889] Build status: SCHEDULED
[10:59:55.889] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:9:0) after 2m3s
[11:01:58.970] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:9:0)
[11:01:58.989] Build status: SCHEDULED
[11:01:58.989] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:10:0) after 3m25s
[11:05:24.232] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:10:0)
[11:05:24.248] Build status: SCHEDULED
[11:05:24.248] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:11:0) after 1m50s
[11:05:35.592] Received PubSub notification, asking Buildbucket for the build status
[11:05:35.614] Build status: STARTED
[11:07:14.293] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:11:0)
[11:07:14.311] Build status: STARTED
[11:07:14.311] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:13:0) after 9m39s
[11:16:53.376] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:13:0)
[11:16:53.396] Build status: STARTED
[11:16:53.396] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:14:0) after 5m45s
[11:22:38.410] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:14:0)
[11:22:38.437] Build status: STARTED
[11:22:38.437] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:15:0) after 1m39s
[11:24:17.459] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:15:0)
[11:24:17.475] Build status: STARTED
[11:24:17.475] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:16:0) after 1m15s
[11:25:32.535] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:16:0)
[11:25:32.557] Build status: STARTED
[11:25:32.557] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:17:0) after 7m35s
[11:33:07.578] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:17:0)
[11:33:07.607] Build status: STARTED
[11:33:07.607] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:18:0) after 7m4s
[11:40:11.673] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:18:0)
[11:40:11.693] Build status: STARTED
[11:40:11.693] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:19:0) after 6m3s
[11:46:14.924] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:19:0)
[11:46:14.938] Build status: STARTED
[11:46:14.938] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:20:0) after 1m46s
[11:48:01.006] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:20:0)
[11:48:01.024] Build status: STARTED
[11:48:01.024] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:21:0) after 8m48s
[11:56:49.041] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:21:0)
[11:56:49.057] Build status: STARTED
[11:56:49.057] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:22:0) after 1m19s
[11:58:08.073] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:22:0)
[11:58:08.159] Build status: STARTED
[11:58:08.159] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:23:0) after 6m10s
[12:04:18.141] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:23:0)
[12:04:18.186] Build status: STARTED
[12:04:18.186] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:24:0) after 8m50s
[12:13:08.202] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:24:0)
[12:13:08.226] Build status: STARTED
[12:13:08.226] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:25:0) after 6m50s
[12:19:58.240] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:25:0)
[12:19:58.257] Build status: STARTED
[12:19:58.257] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:26:0) after 2m48s
[12:22:46.330] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:26:0)
[12:22:46.359] Build status: STARTED
[12:22:46.359] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:27:0) after 6m14s
[12:29:00.434] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:27:0)
[12:29:00.508] Build status: STARTED
[12:29:00.508] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:28:0) after 9m38s
[12:38:38.577] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:28:0)
[12:38:38.598] Build status: STARTED
[12:38:38.598] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:29:0) after 2m18s
[12:40:56.778] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:29:0)
[12:40:56.812] Build status: STARTED
[12:40:56.812] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:30:0) after 7m37s
[12:48:34.025] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:30:0)
[12:48:34.061] Build status: STARTED
[12:48:34.061] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:31:0) after 3m23s
[12:51:57.076] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:31:0)
[12:51:57.093] Build status: STARTED
[12:51:57.093] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:32:0) after 9m44s
[13:01:41.164] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:32:0)
[13:01:41.187] Build status: STARTED
[13:01:41.187] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:33:0) after 3m4s
[13:04:45.230] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:33:0)
[13:04:45.320] Build status: STARTED
[13:04:45.320] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:34:0) after 5m50s
[13:10:35.304] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:34:0)
[13:10:35.328] Build status: STARTED
[13:10:35.328] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:35:0) after 7m22s
[13:17:57.478] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:35:0)
[13:17:57.495] Build status: STARTED
[13:17:57.495] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:36:0) after 4m24s
[13:22:21.639] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:36:0)
[13:22:21.657] Build status: STARTED
[13:22:21.657] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:37:0) after 4m56s
[13:27:17.674] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:37:0)
[13:27:17.700] Build status: STARTED
[13:27:17.700] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:38:0) after 7m38s
[13:34:55.824] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:38:0)
[13:34:55.975] Build status: STARTED
[13:34:55.976] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:39:0) after 1m54s
[13:36:50.001] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:39:0)
[13:36:50.034] Build status: STARTED
[13:36:50.034] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:40:0) after 6m59s
[13:43:49.172] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:40:0)
[13:43:49.190] Build status: STARTED
[13:43:49.190] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:41:0) after 1m35s
[13:45:24.258] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:41:0)
[13:45:24.287] Build status: STARTED
[13:45:24.287] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:42:0) after 6m3s
[13:51:27.326] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:42:0)
[13:51:27.345] Build status: STARTED
[13:51:27.345] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:43:0) after 3m59s
[13:55:26.364] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:43:0)
[13:55:26.386] Build status: STARTED
[13:55:26.386] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:44:0) after 3m51s
[13:59:17.411] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:44:0)
[13:59:17.443] Build status: STARTED
[13:59:17.443] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:45:0) after 3m3s
[14:02:20.461] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:45:0)
[14:02:20.485] Build status: STARTED
[14:02:20.485] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:46:0) after 4m33s
[14:06:53.551] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:46:0)
[14:06:53.568] Build status: STARTED
[14:06:53.568] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:47:0) after 1m31s
[14:08:24.583] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:47:0)
[14:08:24.600] Build status: STARTED
[14:08:24.600] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:48:0) after 7m21s
[14:15:45.615] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:48:0)
[14:15:45.643] Build status: STARTED
[14:15:45.643] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8850435144800244496:49:0) after 2m4s
[14:15:48.971] Received PubSub notification, asking Buildbucket for the build status
[14:15:49.010] Build:
{
"id": "8685005082863228737",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-official"
},
"number": 14,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-09T10:32:16.823263060Z",
"startTime": "2026-04-09T11:05:35.285518282Z",
"endTime": "2026-04-09T14:15:48.308457995Z",
"updateTime": "2026-04-09T14:15:48.308457995Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8fa4281bde0ff1d4f234a7cf9e544f3e2dbaf109",
"ref": "refs/branch-heads/7778"
}
}
}
[14:15:49.010] Invocation finished in 3h43m33.418555974s with status SUCCEEDED