[21:44:38.642] New invocation is queued and will start shortly
[21:44:40.233] Starting the invocation (attempt 1)
[21:44:40.257] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/62c8023d1a0b429d1607c6ca79e5bb08534253ae"
[21:44:40.257] Popped gitiles commit info from properties and tags
[21:44:40.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:44:40.257] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:44:40.258] Buildbucket request:
{
"requestId": "8841061354512447504",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8841061354512447504",
"job": "chromium-m151/win-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "566a2cd51dbffa1f3ee589069515daf395f63197"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@566a2cd51dbffa1f3ee589069515daf395f63197",
"title": "566a2cd51dbffa1f3ee589069515daf395f63197",
"url": "https://chromium.googlesource.com/chromium/src/+/566a2cd51dbffa1f3ee589069515daf395f63197"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2eb40503064f32656d512270f348b2350a493a2b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@2eb40503064f32656d512270f348b2350a493a2b",
"title": "2eb40503064f32656d512270f348b2350a493a2b",
"url": "https://chromium.googlesource.com/chromium/src/+/2eb40503064f32656d512270f348b2350a493a2b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a08a60d34ebce3368316051a0167d9f61e8addb8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@a08a60d34ebce3368316051a0167d9f61e8addb8",
"title": "a08a60d34ebce3368316051a0167d9f61e8addb8",
"url": "https://chromium.googlesource.com/chromium/src/+/a08a60d34ebce3368316051a0167d9f61e8addb8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4aadd1e033207f2acea58b63b80e3a963e5149c3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@4aadd1e033207f2acea58b63b80e3a963e5149c3",
"title": "4aadd1e033207f2acea58b63b80e3a963e5149c3",
"url": "https://chromium.googlesource.com/chromium/src/+/4aadd1e033207f2acea58b63b80e3a963e5149c3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "14738ce2fe7d86ce8890f182b4a91f92516bfc5e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@14738ce2fe7d86ce8890f182b4a91f92516bfc5e",
"title": "14738ce2fe7d86ce8890f182b4a91f92516bfc5e",
"url": "https://chromium.googlesource.com/chromium/src/+/14738ce2fe7d86ce8890f182b4a91f92516bfc5e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fae6e26893d459cb5acacdd8819af9991e35d290"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@fae6e26893d459cb5acacdd8819af9991e35d290",
"title": "fae6e26893d459cb5acacdd8819af9991e35d290",
"url": "https://chromium.googlesource.com/chromium/src/+/fae6e26893d459cb5acacdd8819af9991e35d290"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92b8e8568688c79fe6189c424644049af29e55c1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@92b8e8568688c79fe6189c424644049af29e55c1",
"title": "92b8e8568688c79fe6189c424644049af29e55c1",
"url": "https://chromium.googlesource.com/chromium/src/+/92b8e8568688c79fe6189c424644049af29e55c1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e46d5ef279c9cd4f571d1a10d2a93d6c57f90142"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@e46d5ef279c9cd4f571d1a10d2a93d6c57f90142",
"title": "e46d5ef279c9cd4f571d1a10d2a93d6c57f90142",
"url": "https://chromium.googlesource.com/chromium/src/+/e46d5ef279c9cd4f571d1a10d2a93d6c57f90142"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "72bc352da36857d0375c598f649bf99e5ef576fb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@72bc352da36857d0375c598f649bf99e5ef576fb",
"title": "72bc352da36857d0375c598f649bf99e5ef576fb",
"url": "https://chromium.googlesource.com/chromium/src/+/72bc352da36857d0375c598f649bf99e5ef576fb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "95b20cffbb52aa44d03f42461b60011209574a35"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@95b20cffbb52aa44d03f42461b60011209574a35",
"title": "95b20cffbb52aa44d03f42461b60011209574a35",
"url": "https://chromium.googlesource.com/chromium/src/+/95b20cffbb52aa44d03f42461b60011209574a35"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "93c421abb6e2f00124c2ba3777257a06fd713573"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@93c421abb6e2f00124c2ba3777257a06fd713573",
"title": "93c421abb6e2f00124c2ba3777257a06fd713573",
"url": "https://chromium.googlesource.com/chromium/src/+/93c421abb6e2f00124c2ba3777257a06fd713573"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92738d568a2c7694a53140f0b3fbc9dad353ec67"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@92738d568a2c7694a53140f0b3fbc9dad353ec67",
"title": "92738d568a2c7694a53140f0b3fbc9dad353ec67",
"url": "https://chromium.googlesource.com/chromium/src/+/92738d568a2c7694a53140f0b3fbc9dad353ec67"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "abe204461d967a66d973f7837a720a32e090d5fc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@abe204461d967a66d973f7837a720a32e090d5fc",
"title": "abe204461d967a66d973f7837a720a32e090d5fc",
"url": "https://chromium.googlesource.com/chromium/src/+/abe204461d967a66d973f7837a720a32e090d5fc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8155f408c7d4434c4856450980ccb8e284968036"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@8155f408c7d4434c4856450980ccb8e284968036",
"title": "8155f408c7d4434c4856450980ccb8e284968036",
"url": "https://chromium.googlesource.com/chromium/src/+/8155f408c7d4434c4856450980ccb8e284968036"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "657aff47846f5acc1f15e8fc01337ac3b6cd758c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@657aff47846f5acc1f15e8fc01337ac3b6cd758c",
"title": "657aff47846f5acc1f15e8fc01337ac3b6cd758c",
"url": "https://chromium.googlesource.com/chromium/src/+/657aff47846f5acc1f15e8fc01337ac3b6cd758c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "62c8023d1a0b429d1607c6ca79e5bb08534253ae"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@62c8023d1a0b429d1607c6ca79e5bb08534253ae",
"title": "62c8023d1a0b429d1607c6ca79e5bb08534253ae",
"url": "https://chromium.googlesource.com/chromium/src/+/62c8023d1a0b429d1607c6ca79e5bb08534253ae"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "62c8023d1a0b429d1607c6ca79e5bb08534253ae",
"ref": "refs/branch-heads/7922"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8841061354512447504"
},
{
"key": "scheduler_job_id",
"value": "chromium-m151/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:44:41.068] Scheduled build:
{
"id": "8675631292087400977",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "win-official"
},
"number": 144,
"createdBy": "project:chromium-m151",
"createTime": "2026-07-21T21:44:40.333898509Z",
"updateTime": "2026-07-21T21:44:40.333898509Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "62c8023d1a0b429d1607c6ca79e5bb08534253ae",
"ref": "refs/branch-heads/7922"
}
}
}
[21:44:41.068] Task URL: https://cr-buildbucket.appspot.com/build/8675631292087400977
[21:44:41.068] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:2:0) after 8m38s
[21:44:47.570] Received PubSub notification, asking Buildbucket for the build status
[21:44:47.595] Build status: STARTED
[21:44:50.024] Received PubSub notification, asking Buildbucket for the build status
[21:44:50.111] Build status: STARTED
[21:53:19.086] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:2:0)
[21:53:19.106] Build status: STARTED
[21:53:19.106] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:5:0) after 2m55s
[21:56:14.169] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:5:0)
[21:56:14.195] Build status: STARTED
[21:56:14.195] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:6:0) after 1m17s
[21:57:31.216] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:6:0)
[21:57:31.239] Build status: STARTED
[21:57:31.239] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:7:0) after 2m28s
[21:59:59.226] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:7:0)
[21:59:59.311] Build status: STARTED
[21:59:59.311] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:8:0) after 7m17s
[22:07:16.330] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:8:0)
[22:07:16.349] Build status: STARTED
[22:07:16.349] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:9:0) after 7m56s
[22:15:12.370] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:9:0)
[22:15:12.534] Build status: STARTED
[22:15:12.534] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:10:0) after 9m6s
[22:24:18.639] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:10:0)
[22:24:18.658] Build status: STARTED
[22:24:18.658] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:11:0) after 4m34s
[22:28:52.749] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:11:0)
[22:28:52.779] Build status: STARTED
[22:28:52.779] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:12:0) after 8m35s
[22:37:27.795] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:12:0)
[22:37:27.864] Build status: STARTED
[22:37:27.864] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:13:0) after 8m18s
[22:45:45.882] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:13:0)
[22:45:45.905] Build status: STARTED
[22:45:45.905] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:14:0) after 7m16s
[22:53:01.968] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:14:0)
[22:53:02.020] Build status: STARTED
[22:53:02.020] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:15:0) after 3m22s
[22:56:24.033] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:15:0)
[22:56:24.109] Build status: STARTED
[22:56:24.109] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:16:0) after 4m22s
[23:00:46.165] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:16:0)
[23:00:46.187] Build status: STARTED
[23:00:46.187] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:17:0) after 7m52s
[23:08:38.227] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:17:0)
[23:08:38.250] Build status: STARTED
[23:08:38.250] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:18:0) after 5m55s
[23:14:33.268] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:18:0)
[23:14:33.299] Build status: STARTED
[23:14:33.299] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:19:0) after 9m11s
[23:23:44.315] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:19:0)
[23:23:44.352] Build status: STARTED
[23:23:44.352] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:20:0) after 5m36s
[23:29:20.514] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:20:0)
[23:29:20.552] Build status: STARTED
[23:29:20.552] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:21:0) after 1m46s
[23:31:06.597] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:21:0)
[23:31:06.617] Build status: STARTED
[23:31:06.618] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:22:0) after 9m2s
[23:40:08.618] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:22:0)
[23:40:08.638] Build status: STARTED
[23:40:08.638] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:23:0) after 5m36s
[23:45:44.736] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:23:0)
[23:45:44.756] Build status: STARTED
[23:45:44.756] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:24:0) after 5m5s
[23:50:49.779] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:24:0)
[23:50:49.806] Build status: STARTED
[23:50:49.806] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:25:0) after 3m42s
[23:54:31.821] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:25:0)
[23:54:31.837] Build status: STARTED
[23:54:31.837] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:26:0) after 4m49s
[23:59:20.820] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:26:0)
[23:59:20.862] Build status: STARTED
[23:59:20.862] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:27:0) after 5m31s
[00:04:51.931] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:27:0)
[00:04:51.961] Build status: STARTED
[00:04:51.961] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:28:0) after 8m56s
[00:13:47.976] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:28:0)
[00:13:47.996] Build status: STARTED
[00:13:47.996] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:29:0) after 6m16s
[00:20:04.040] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:29:0)
[00:20:04.073] Build status: STARTED
[00:20:04.073] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:30:0) after 2m33s
[00:22:37.055] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:30:0)
[00:22:37.113] Build status: STARTED
[00:22:37.113] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:31:0) after 2m6s
[00:24:43.410] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:31:0)
[00:24:43.481] Build status: STARTED
[00:24:43.481] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:32:0) after 9m44s
[00:34:27.500] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:32:0)
[00:34:27.519] Build status: STARTED
[00:34:27.519] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:33:0) after 8m5s
[00:42:32.592] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:33:0)
[00:42:32.607] Build status: STARTED
[00:42:32.607] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:34:0) after 9m55s
[00:52:27.622] Handling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:34:0)
[00:52:27.642] Build status: STARTED
[00:52:27.642] Scheduling timer "check-buildbucket-build-status" (chromium-m151/win-official:8841061354512447504:35:0) after 4m25s
[00:53:18.649] Received PubSub notification, asking Buildbucket for the build status
[00:53:18.673] Build:
{
"id": "8675631292087400977",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "win-official"
},
"number": 144,
"createdBy": "project:chromium-m151",
"createTime": "2026-07-21T21:44:40.333898509Z",
"startTime": "2026-07-21T21:44:46.527070835Z",
"endTime": "2026-07-22T00:53:18.340246457Z",
"updateTime": "2026-07-22T00:53:18.340246457Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "62c8023d1a0b429d1607c6ca79e5bb08534253ae",
"ref": "refs/branch-heads/7922"
}
}
}
[00:53:18.673] Invocation finished in 3h8m40.035961035s with status SUCCEEDED