[21:03:50.558] New invocation is queued and will start shortly
[21:03:51.727] Starting the invocation (attempt 1)
[21:03:51.751] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44"
[21:03:51.751] Popped gitiles commit info from properties and tags
[21:03:51.751] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:03:51.751] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:03:51.752] Buildbucket request:
{
"requestId": "8834631536900045536",
"builder": {
"project": "chromium-m156",
"bucket": "ci",
"builder": "win32-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8834631536900045536",
"job": "chromium-m156/win32-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9daea141cc00bb3eb121de1b3bd27ec32367cc43"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@9daea141cc00bb3eb121de1b3bd27ec32367cc43",
"title": "9daea141cc00bb3eb121de1b3bd27ec32367cc43",
"url": "https://chromium.googlesource.com/chromium/src/+/9daea141cc00bb3eb121de1b3bd27ec32367cc43"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c880996157c074745e076df79c2448ab0f42fe30"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@c880996157c074745e076df79c2448ab0f42fe30",
"title": "c880996157c074745e076df79c2448ab0f42fe30",
"url": "https://chromium.googlesource.com/chromium/src/+/c880996157c074745e076df79c2448ab0f42fe30"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9b455d93c90cc02cb46a293012107181f1a0d2b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@9b455d93c90cc02cb46a293012107181f1a0d2b1",
"title": "9b455d93c90cc02cb46a293012107181f1a0d2b1",
"url": "https://chromium.googlesource.com/chromium/src/+/9b455d93c90cc02cb46a293012107181f1a0d2b1"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8539ec8fbd7cd42ca1fd9a6da8c7dc13f7391f02"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@8539ec8fbd7cd42ca1fd9a6da8c7dc13f7391f02",
"title": "8539ec8fbd7cd42ca1fd9a6da8c7dc13f7391f02",
"url": "https://chromium.googlesource.com/chromium/src/+/8539ec8fbd7cd42ca1fd9a6da8c7dc13f7391f02"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "75cdd0435447ea1bb4c877e0d6dce6f801c4adc0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@75cdd0435447ea1bb4c877e0d6dce6f801c4adc0",
"title": "75cdd0435447ea1bb4c877e0d6dce6f801c4adc0",
"url": "https://chromium.googlesource.com/chromium/src/+/75cdd0435447ea1bb4c877e0d6dce6f801c4adc0"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "061d5698ef2bfa395415501f0bd9d42c96544c35"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@061d5698ef2bfa395415501f0bd9d42c96544c35",
"title": "061d5698ef2bfa395415501f0bd9d42c96544c35",
"url": "https://chromium.googlesource.com/chromium/src/+/061d5698ef2bfa395415501f0bd9d42c96544c35"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a5e59fa77bc2a843d88d4ec62d60eb4bc5243776"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@a5e59fa77bc2a843d88d4ec62d60eb4bc5243776",
"title": "a5e59fa77bc2a843d88d4ec62d60eb4bc5243776",
"url": "https://chromium.googlesource.com/chromium/src/+/a5e59fa77bc2a843d88d4ec62d60eb4bc5243776"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "95806839fc33ad7e8154385ea2efbc10965021d2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@95806839fc33ad7e8154385ea2efbc10965021d2",
"title": "95806839fc33ad7e8154385ea2efbc10965021d2",
"url": "https://chromium.googlesource.com/chromium/src/+/95806839fc33ad7e8154385ea2efbc10965021d2"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9b457672c2fe5e19da7e79376946f14758f0bfe2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@9b457672c2fe5e19da7e79376946f14758f0bfe2",
"title": "9b457672c2fe5e19da7e79376946f14758f0bfe2",
"url": "https://chromium.googlesource.com/chromium/src/+/9b457672c2fe5e19da7e79376946f14758f0bfe2"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ad06115bea5ca949818016aabdf6d598f175d706"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@ad06115bea5ca949818016aabdf6d598f175d706",
"title": "ad06115bea5ca949818016aabdf6d598f175d706",
"url": "https://chromium.googlesource.com/chromium/src/+/ad06115bea5ca949818016aabdf6d598f175d706"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f03f532fd33bb650169a8365ed21cd521df8a38"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@4f03f532fd33bb650169a8365ed21cd521df8a38",
"title": "4f03f532fd33bb650169a8365ed21cd521df8a38",
"url": "https://chromium.googlesource.com/chromium/src/+/4f03f532fd33bb650169a8365ed21cd521df8a38"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a2eeecc003cc20da9287384561d311f904a6efbc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@a2eeecc003cc20da9287384561d311f904a6efbc",
"title": "a2eeecc003cc20da9287384561d311f904a6efbc",
"url": "https://chromium.googlesource.com/chromium/src/+/a2eeecc003cc20da9287384561d311f904a6efbc"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5800967105628c1cfeb21bd24c28c2ff1aab26cf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@5800967105628c1cfeb21bd24c28c2ff1aab26cf",
"title": "5800967105628c1cfeb21bd24c28c2ff1aab26cf",
"url": "https://chromium.googlesource.com/chromium/src/+/5800967105628c1cfeb21bd24c28c2ff1aab26cf"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "49879304e96a005b4511b0a913f4f15c5edf0f53"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@49879304e96a005b4511b0a913f4f15c5edf0f53",
"title": "49879304e96a005b4511b0a913f4f15c5edf0f53",
"url": "https://chromium.googlesource.com/chromium/src/+/49879304e96a005b4511b0a913f4f15c5edf0f53"
},
{
"gitiles": {
"ref": "refs/branch-heads/8078",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8078@89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44",
"title": "89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44",
"url": "https://chromium.googlesource.com/chromium/src/+/89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44",
"ref": "refs/branch-heads/8078"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8834631536900045536"
},
{
"key": "scheduler_job_id",
"value": "chromium-m156/win32-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:03:52.318] Scheduled build:
{
"id": "8669201474901470881",
"builder": {
"project": "chromium-m156",
"bucket": "ci",
"builder": "win32-official"
},
"number": 7,
"createdBy": "project:chromium-m156",
"createTime": "2026-09-30T21:03:51.843184290Z",
"updateTime": "2026-09-30T21:03:51.843184290Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44",
"ref": "refs/branch-heads/8078"
}
}
}
[21:03:52.318] Task URL: https://cr-buildbucket.appspot.com/build/8669201474901470881
[21:03:52.318] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:2:0) after 2m12s
[21:03:53.268] Received PubSub notification, asking Buildbucket for the build status
[21:03:53.290] Build status: SCHEDULED
[21:06:04.368] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:2:0)
[21:06:04.392] Build status: SCHEDULED
[21:06:04.392] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:4:0) after 3m30s
[21:09:34.465] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:4:0)
[21:09:34.523] Build status: SCHEDULED
[21:09:34.523] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:5:0) after 4m18s
[21:13:52.544] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:5:0)
[21:13:52.572] Build status: SCHEDULED
[21:13:52.572] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:6:0) after 5m9s
[21:19:01.587] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:6:0)
[21:19:01.687] Build status: SCHEDULED
[21:19:01.688] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:7:0) after 8m5s
[21:27:06.707] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:7:0)
[21:27:06.731] Build status: SCHEDULED
[21:27:06.731] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:8:0) after 7m24s
[21:34:30.834] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:8:0)
[21:34:30.856] Build status: SCHEDULED
[21:34:30.856] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:9:0) after 1m59s
[21:36:29.905] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:9:0)
[21:36:29.926] Build status: SCHEDULED
[21:36:29.926] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:10:0) after 7m49s
[21:44:18.972] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:10:0)
[21:44:18.993] Build status: SCHEDULED
[21:44:18.993] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:11:0) after 2m16s
[21:46:35.070] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:11:0)
[21:46:35.101] Build status: SCHEDULED
[21:46:35.102] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:12:0) after 6m57s
[21:53:32.122] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:12:0)
[21:53:32.144] Build status: SCHEDULED
[21:53:32.144] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:13:0) after 8m36s
[22:02:08.227] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:13:0)
[22:02:08.252] Build status: SCHEDULED
[22:02:08.253] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:14:0) after 2m2s
[22:04:10.276] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:14:0)
[22:04:10.308] Build status: SCHEDULED
[22:04:10.308] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:15:0) after 2m50s
[22:07:00.325] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:15:0)
[22:07:00.343] Build status: SCHEDULED
[22:07:00.343] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:16:0) after 6m9s
[22:13:09.398] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:16:0)
[22:13:09.456] Build status: SCHEDULED
[22:13:09.456] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:17:0) after 1m47s
[22:14:56.473] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:17:0)
[22:14:56.498] Build status: SCHEDULED
[22:14:56.498] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:18:0) after 2m59s
[22:17:55.536] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:18:0)
[22:17:55.559] Build status: SCHEDULED
[22:17:55.559] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:19:0) after 6m3s
[22:23:58.564] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:19:0)
[22:23:58.585] Build status: SCHEDULED
[22:23:58.585] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:20:0) after 7m54s
[22:31:52.660] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:20:0)
[22:31:52.685] Build status: SCHEDULED
[22:31:52.685] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:21:0) after 2m44s
[22:34:36.782] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:21:0)
[22:34:36.834] Build status: SCHEDULED
[22:34:36.834] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:22:0) after 4m40s
[22:39:16.855] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:22:0)
[22:39:16.879] Build status: SCHEDULED
[22:39:16.879] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:23:0) after 1m10s
[22:40:26.914] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:23:0)
[22:40:26.934] Build status: SCHEDULED
[22:40:26.934] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:24:0) after 2m54s
[22:43:21.067] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:24:0)
[22:43:21.089] Build status: SCHEDULED
[22:43:21.089] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:25:0) after 1m54s
[22:45:15.136] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:25:0)
[22:45:15.164] Build status: SCHEDULED
[22:45:15.164] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:26:0) after 8m47s
[22:54:02.375] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:26:0)
[22:54:02.415] Build status: SCHEDULED
[22:54:02.415] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:27:0) after 9m1s
[23:03:03.634] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:27:0)
[23:03:03.657] Build status: SCHEDULED
[23:03:03.657] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:28:0) after 9m34s
[23:12:37.847] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:28:0)
[23:12:37.869] Build status: SCHEDULED
[23:12:37.869] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:29:0) after 2m2s
[23:14:40.100] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:29:0)
[23:14:40.129] Build status: SCHEDULED
[23:14:40.129] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:30:0) after 1m16s
[23:15:56.179] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:30:0)
[23:15:56.198] Build status: SCHEDULED
[23:15:56.198] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:31:0) after 5m13s
[23:21:09.195] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:31:0)
[23:21:09.212] Build status: SCHEDULED
[23:21:09.212] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:32:0) after 3m31s
[23:24:40.229] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:32:0)
[23:24:40.249] Build status: SCHEDULED
[23:24:40.249] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:33:0) after 4m14s
[23:28:54.423] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:33:0)
[23:28:54.446] Build status: SCHEDULED
[23:28:54.447] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:34:0) after 6m26s
[23:35:20.426] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:34:0)
[23:35:20.459] Build status: SCHEDULED
[23:35:20.459] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:35:0) after 8m8s
[23:43:28.482] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:35:0)
[23:43:28.500] Build status: SCHEDULED
[23:43:28.500] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:36:0) after 9m31s
[23:52:59.538] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:36:0)
[23:52:59.568] Build status: SCHEDULED
[23:52:59.568] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:37:0) after 6m49s
[23:59:48.585] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:37:0)
[23:59:48.622] Build status: SCHEDULED
[23:59:48.622] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:38:0) after 3m38s
[00:03:26.644] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:38:0)
[00:03:26.667] Build status: SCHEDULED
[00:03:26.667] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:39:0) after 9m49s
[00:04:15.515] Received PubSub notification, asking Buildbucket for the build status
[00:04:15.565] Build status: STARTED
[00:13:15.718] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:39:0)
[00:13:15.738] Build status: STARTED
[00:13:15.738] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:41:0) after 7m46s
[00:21:01.835] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:41:0)
[00:21:01.863] Build status: STARTED
[00:21:01.863] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:42:0) after 6m35s
[00:27:36.892] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:42:0)
[00:27:36.946] Build status: STARTED
[00:27:36.946] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:43:0) after 6m9s
[00:33:45.946] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:43:0)
[00:33:45.965] Build status: STARTED
[00:33:45.965] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:44:0) after 9m55s
[00:43:41.082] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:44:0)
[00:43:41.098] Build status: STARTED
[00:43:41.098] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:45:0) after 9m34s
[00:53:15.397] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:45:0)
[00:53:15.420] Build status: STARTED
[00:53:15.420] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:46:0) after 3m54s
[00:57:09.513] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:46:0)
[00:57:09.532] Build status: STARTED
[00:57:09.532] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:47:0) after 4m9s
[01:01:18.603] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:47:0)
[01:01:18.624] Build status: STARTED
[01:01:18.624] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:48:0) after 4m41s
[01:05:59.750] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:48:0)
[01:05:59.799] Build status: STARTED
[01:05:59.799] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:49:0) after 1m52s
[01:07:51.815] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:49:0)
[01:07:51.866] Build status: STARTED
[01:07:51.866] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:50:0) after 7m43s
[01:15:35.002] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:50:0)
[01:15:35.040] Build status: STARTED
[01:15:35.040] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:51:0) after 4m30s
[01:20:05.155] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:51:0)
[01:20:05.175] Build status: STARTED
[01:20:05.175] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:52:0) after 5m58s
[01:26:03.270] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:52:0)
[01:26:03.322] Build status: STARTED
[01:26:03.322] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:53:0) after 9m5s
[01:35:08.347] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:53:0)
[01:35:08.380] Build status: STARTED
[01:35:08.380] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:54:0) after 3m21s
[01:38:29.499] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:54:0)
[01:38:29.520] Build status: STARTED
[01:38:29.520] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:55:0) after 3m42s
[01:42:11.538] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:55:0)
[01:42:11.557] Build status: STARTED
[01:42:11.557] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:56:0) after 4m11s
[01:46:22.624] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:56:0)
[01:46:22.647] Build status: STARTED
[01:46:22.648] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:57:0) after 8m41s
[01:55:03.715] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:57:0)
[01:55:03.736] Build status: STARTED
[01:55:03.736] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:58:0) after 6m29s
[02:01:33.096] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:58:0)
[02:01:33.146] Build status: STARTED
[02:01:33.146] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:59:0) after 7m39s
[02:09:12.168] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:59:0)
[02:09:12.189] Build status: STARTED
[02:09:12.189] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:60:0) after 8m30s
[02:17:42.194] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:60:0)
[02:17:42.343] Build status: STARTED
[02:17:42.343] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:61:0) after 4m12s
[02:21:54.522] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:61:0)
[02:21:54.544] Build status: STARTED
[02:21:54.544] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:62:0) after 8m25s
[02:30:19.619] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:62:0)
[02:30:19.641] Build status: STARTED
[02:30:19.641] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:63:0) after 3m35s
[02:33:54.701] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:63:0)
[02:33:54.743] Build status: STARTED
[02:33:54.743] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:64:0) after 2m29s
[02:36:23.763] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:64:0)
[02:36:23.784] Build status: STARTED
[02:36:23.784] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:65:0) after 3m50s
[02:40:13.917] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:65:0)
[02:40:13.951] Build status: STARTED
[02:40:13.951] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:66:0) after 5m39s
[02:45:52.932] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:66:0)
[02:45:52.960] Build status: STARTED
[02:45:52.960] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:67:0) after 7m9s
[02:53:02.033] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:67:0)
[02:53:02.058] Build status: STARTED
[02:53:02.058] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:68:0) after 2m52s
[02:55:54.074] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:68:0)
[02:55:54.099] Build status: STARTED
[02:55:54.099] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:69:0) after 3m39s
[02:59:33.113] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:69:0)
[02:59:33.144] Build status: STARTED
[02:59:33.144] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:70:0) after 6m57s
[03:06:30.168] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:70:0)
[03:06:30.189] Build status: STARTED
[03:06:30.190] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:71:0) after 1m6s
[03:07:36.206] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:71:0)
[03:07:36.228] Build status: STARTED
[03:07:36.228] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:72:0) after 5m22s
[03:12:58.302] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:72:0)
[03:12:58.324] Build status: STARTED
[03:12:58.324] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:73:0) after 9m25s
[03:22:23.343] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:73:0)
[03:22:23.367] Build status: STARTED
[03:22:23.367] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:74:0) after 7m41s
[03:30:04.430] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:74:0)
[03:30:04.481] Build status: STARTED
[03:30:04.481] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:75:0) after 2m51s
[03:32:55.541] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:75:0)
[03:32:55.560] Build status: STARTED
[03:32:55.560] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:76:0) after 4m52s
[03:37:47.629] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:76:0)
[03:37:47.651] Build status: STARTED
[03:37:47.651] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:77:0) after 7m33s
[03:45:20.820] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:77:0)
[03:45:20.842] Build status: STARTED
[03:45:20.842] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:78:0) after 5m33s
[03:50:53.859] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:78:0)
[03:50:54.004] Build status: STARTED
[03:50:54.004] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:79:0) after 1m20s
[03:52:14.139] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:79:0)
[03:52:14.160] Build status: STARTED
[03:52:14.160] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:80:0) after 7m30s
[03:59:44.182] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:80:0)
[03:59:44.200] Build status: STARTED
[03:59:44.200] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:81:0) after 5m56s
[04:05:40.281] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:81:0)
[04:05:40.305] Build status: STARTED
[04:05:40.305] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:82:0) after 1m33s
[04:07:13.382] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:82:0)
[04:07:13.403] Build status: STARTED
[04:07:13.403] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:83:0) after 8m46s
[04:15:59.466] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:83:0)
[04:15:59.491] Build status: STARTED
[04:15:59.492] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:84:0) after 7m54s
[04:23:53.647] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:84:0)
[04:23:53.680] Build status: STARTED
[04:23:53.680] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:85:0) after 1m10s
[04:25:03.884] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:85:0)
[04:25:03.904] Build status: STARTED
[04:25:03.904] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:86:0) after 2m57s
[04:28:01.038] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:86:0)
[04:28:01.061] Build status: STARTED
[04:28:01.061] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:87:0) after 8m27s
[04:36:28.118] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:87:0)
[04:36:28.149] Build status: STARTED
[04:36:28.149] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:88:0) after 1m12s
[04:37:40.182] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:88:0)
[04:37:40.202] Build status: STARTED
[04:37:40.202] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:89:0) after 1m48s
[04:39:28.226] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:89:0)
[04:39:28.260] Build status: STARTED
[04:39:28.260] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:90:0) after 1m45s
[04:41:13.357] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:90:0)
[04:41:13.388] Build status: STARTED
[04:41:13.388] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:91:0) after 2m36s
[04:43:49.484] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:91:0)
[04:43:49.511] Build status: STARTED
[04:43:49.512] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:92:0) after 5m16s
[04:49:05.531] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:92:0)
[04:49:05.562] Build status: STARTED
[04:49:05.562] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:93:0) after 1m18s
[04:50:23.659] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:93:0)
[04:50:23.748] Build status: STARTED
[04:50:23.748] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:94:0) after 2m54s
[04:53:17.765] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:94:0)
[04:53:17.787] Build status: STARTED
[04:53:17.787] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:95:0) after 6m14s
[04:59:31.807] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:95:0)
[04:59:31.827] Build status: STARTED
[04:59:31.827] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:96:0) after 5m40s
[05:05:11.843] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:96:0)
[05:05:11.865] Build status: STARTED
[05:05:11.865] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:97:0) after 1m6s
[05:06:17.913] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:97:0)
[05:06:17.929] Build status: STARTED
[05:06:17.929] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:98:0) after 4m13s
[05:10:30.959] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:98:0)
[05:10:30.984] Build status: STARTED
[05:10:30.984] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:99:0) after 2m44s
[05:13:15.029] Handling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:99:0)
[05:13:15.048] Build status: STARTED
[05:13:15.048] Scheduling timer "check-buildbucket-build-status" (chromium-m156/win32-official:8834631536900045536:100:0) after 6m59s
[05:17:32.914] Received PubSub notification, asking Buildbucket for the build status
[05:17:32.933] Build:
{
"id": "8669201474901470881",
"builder": {
"project": "chromium-m156",
"bucket": "ci",
"builder": "win32-official"
},
"number": 7,
"createdBy": "project:chromium-m156",
"createTime": "2026-09-30T21:03:51.843184290Z",
"startTime": "2026-10-01T00:04:15.248507538Z",
"endTime": "2026-10-01T05:17:32.330856391Z",
"updateTime": "2026-10-01T05:17:32.330856391Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "89c1a4aa0c5dbf39953b38c29c9508df8b2a1d44",
"ref": "refs/branch-heads/8078"
}
}
}
[05:17:32.933] Invocation finished in 8h13m42.380610948s with status SUCCEEDED