[03:19:08.762] New invocation is queued and will start shortly
[03:19:18.909] Starting the invocation (attempt 1)
[03:19:18.931] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b87f84dee49ab4431ca86bda6d75ad9ce7f245bd"
[03:19:18.931] Popped gitiles commit info from properties and tags
[03:19:18.931] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:19:18.931] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:19:18.932] Buildbucket request:
{
"requestId": "8856170002860014144",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8856170002860014144",
"job": "chromium-m145/win-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9d195309b629e2d0c51df12a28c2f92dc57d5ada"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@9d195309b629e2d0c51df12a28c2f92dc57d5ada",
"title": "9d195309b629e2d0c51df12a28c2f92dc57d5ada",
"url": "https://chromium.googlesource.com/chromium/src/+/9d195309b629e2d0c51df12a28c2f92dc57d5ada"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8962eebede2feec4771fe06f593560884b11819d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@8962eebede2feec4771fe06f593560884b11819d",
"title": "8962eebede2feec4771fe06f593560884b11819d",
"url": "https://chromium.googlesource.com/chromium/src/+/8962eebede2feec4771fe06f593560884b11819d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e30d8d23eaa0e17f5ff1efa098a0ff77f80dd078"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@e30d8d23eaa0e17f5ff1efa098a0ff77f80dd078",
"title": "e30d8d23eaa0e17f5ff1efa098a0ff77f80dd078",
"url": "https://chromium.googlesource.com/chromium/src/+/e30d8d23eaa0e17f5ff1efa098a0ff77f80dd078"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "08709a25160930f9074329c9f20876085d61f03b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@08709a25160930f9074329c9f20876085d61f03b",
"title": "08709a25160930f9074329c9f20876085d61f03b",
"url": "https://chromium.googlesource.com/chromium/src/+/08709a25160930f9074329c9f20876085d61f03b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a593fc6597299bbe68948671ca9841fb9ad76e7f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@a593fc6597299bbe68948671ca9841fb9ad76e7f",
"title": "a593fc6597299bbe68948671ca9841fb9ad76e7f",
"url": "https://chromium.googlesource.com/chromium/src/+/a593fc6597299bbe68948671ca9841fb9ad76e7f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "007621cba7f84eb0b0e699b069f0647c33e1258b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@007621cba7f84eb0b0e699b069f0647c33e1258b",
"title": "007621cba7f84eb0b0e699b069f0647c33e1258b",
"url": "https://chromium.googlesource.com/chromium/src/+/007621cba7f84eb0b0e699b069f0647c33e1258b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1c01e7d6692a8de5c2403565ba9a9e69bb5c9b70"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@1c01e7d6692a8de5c2403565ba9a9e69bb5c9b70",
"title": "1c01e7d6692a8de5c2403565ba9a9e69bb5c9b70",
"url": "https://chromium.googlesource.com/chromium/src/+/1c01e7d6692a8de5c2403565ba9a9e69bb5c9b70"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c911ceecd4fa3b1b507c2c58a13be3b2ea37617f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@c911ceecd4fa3b1b507c2c58a13be3b2ea37617f",
"title": "c911ceecd4fa3b1b507c2c58a13be3b2ea37617f",
"url": "https://chromium.googlesource.com/chromium/src/+/c911ceecd4fa3b1b507c2c58a13be3b2ea37617f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3ef3a9a783e87e8cd4847206b9cf5497c06b3dc4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@3ef3a9a783e87e8cd4847206b9cf5497c06b3dc4",
"title": "3ef3a9a783e87e8cd4847206b9cf5497c06b3dc4",
"url": "https://chromium.googlesource.com/chromium/src/+/3ef3a9a783e87e8cd4847206b9cf5497c06b3dc4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "04960ff8ade3c2639aa94a6d046139323dde0573"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@04960ff8ade3c2639aa94a6d046139323dde0573",
"title": "04960ff8ade3c2639aa94a6d046139323dde0573",
"url": "https://chromium.googlesource.com/chromium/src/+/04960ff8ade3c2639aa94a6d046139323dde0573"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "067a08a70a2bb96a24d286155b65b3a73aa2f451"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@067a08a70a2bb96a24d286155b65b3a73aa2f451",
"title": "067a08a70a2bb96a24d286155b65b3a73aa2f451",
"url": "https://chromium.googlesource.com/chromium/src/+/067a08a70a2bb96a24d286155b65b3a73aa2f451"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8d68bde96877a1f87f48e552009c13f637189083"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@8d68bde96877a1f87f48e552009c13f637189083",
"title": "8d68bde96877a1f87f48e552009c13f637189083",
"url": "https://chromium.googlesource.com/chromium/src/+/8d68bde96877a1f87f48e552009c13f637189083"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7b074898d8fafaac2ddd1055c1f24185dd5f92be"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@7b074898d8fafaac2ddd1055c1f24185dd5f92be",
"title": "7b074898d8fafaac2ddd1055c1f24185dd5f92be",
"url": "https://chromium.googlesource.com/chromium/src/+/7b074898d8fafaac2ddd1055c1f24185dd5f92be"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1c0c07313ae19973bf751fc50de213a4b9b479de"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@1c0c07313ae19973bf751fc50de213a4b9b479de",
"title": "1c0c07313ae19973bf751fc50de213a4b9b479de",
"url": "https://chromium.googlesource.com/chromium/src/+/1c0c07313ae19973bf751fc50de213a4b9b479de"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8673c7aead62a2e147e3d57daaa76d47d3240d1e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@8673c7aead62a2e147e3d57daaa76d47d3240d1e",
"title": "8673c7aead62a2e147e3d57daaa76d47d3240d1e",
"url": "https://chromium.googlesource.com/chromium/src/+/8673c7aead62a2e147e3d57daaa76d47d3240d1e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b87f84dee49ab4431ca86bda6d75ad9ce7f245bd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@b87f84dee49ab4431ca86bda6d75ad9ce7f245bd",
"title": "b87f84dee49ab4431ca86bda6d75ad9ce7f245bd",
"url": "https://chromium.googlesource.com/chromium/src/+/b87f84dee49ab4431ca86bda6d75ad9ce7f245bd"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b87f84dee49ab4431ca86bda6d75ad9ce7f245bd",
"ref": "refs/branch-heads/7632"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8856170002860014144"
},
{
"key": "scheduler_job_id",
"value": "chromium-m145/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:19:19.515] Scheduled build:
{
"id": "8690739931450618481",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "win-official"
},
"number": 173,
"createdBy": "project:chromium-m145",
"createTime": "2026-02-05T03:19:19.017613325Z",
"updateTime": "2026-02-05T03:19:19.017613325Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b87f84dee49ab4431ca86bda6d75ad9ce7f245bd",
"ref": "refs/branch-heads/7632"
}
}
}
[03:19:19.515] Task URL: https://cr-buildbucket.appspot.com/build/8690739931450618481
[03:19:19.515] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:2:0) after 4m56s
[03:19:20.532] Received PubSub notification, asking Buildbucket for the build status
[03:19:20.604] Build status: SCHEDULED
[03:19:23.658] Received PubSub notification, asking Buildbucket for the build status
[03:19:23.676] Build status: STARTED
[03:24:15.541] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:2:0)
[03:24:15.825] Build status: STARTED
[03:24:15.825] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:5:0) after 2m0s
[03:26:15.865] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:5:0)
[03:26:15.881] Build status: STARTED
[03:26:15.881] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:6:0) after 7m58s
[03:34:13.900] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:6:0)
[03:34:13.922] Build status: STARTED
[03:34:13.922] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:7:0) after 9m53s
[03:44:06.966] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:7:0)
[03:44:07.000] Build status: STARTED
[03:44:07.000] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:8:0) after 5m9s
[03:49:16.110] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:8:0)
[03:49:16.135] Build status: STARTED
[03:49:16.135] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:9:0) after 1m9s
[03:50:25.159] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:9:0)
[03:50:25.175] Build status: STARTED
[03:50:25.175] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:10:0) after 9m54s
[04:00:19.292] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:10:0)
[04:00:19.441] Build status: STARTED
[04:00:19.441] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:11:0) after 8m46s
[04:09:05.519] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:11:0)
[04:09:05.532] Build status: STARTED
[04:09:05.532] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:12:0) after 3m51s
[04:12:56.548] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:12:0)
[04:12:56.565] Build status: STARTED
[04:12:56.565] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:13:0) after 1m1s
[04:13:57.580] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:13:0)
[04:13:57.596] Build status: STARTED
[04:13:57.596] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:14:0) after 3m34s
[04:17:31.602] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:14:0)
[04:17:31.664] Build status: STARTED
[04:17:31.664] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:15:0) after 2m6s
[04:19:37.681] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:15:0)
[04:19:37.695] Build status: STARTED
[04:19:37.695] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:16:0) after 1m16s
[04:20:53.831] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:16:0)
[04:20:53.845] Build status: STARTED
[04:20:53.845] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:17:0) after 8m39s
[04:29:32.861] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:17:0)
[04:29:32.877] Build status: STARTED
[04:29:32.877] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:18:0) after 9m40s
[04:39:12.919] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:18:0)
[04:39:12.934] Build status: STARTED
[04:39:12.934] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:19:0) after 2m48s
[04:42:01.039] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:19:0)
[04:42:01.065] Build status: STARTED
[04:42:01.065] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:20:0) after 9m50s
[04:51:51.123] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:20:0)
[04:51:51.140] Build status: STARTED
[04:51:51.140] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:21:0) after 3m24s
[04:55:15.195] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:21:0)
[04:55:15.209] Build status: STARTED
[04:55:15.209] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:22:0) after 6m44s
[05:01:59.232] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:22:0)
[05:01:59.250] Build status: STARTED
[05:01:59.250] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:23:0) after 7m12s
[05:09:11.374] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:23:0)
[05:09:11.473] Build status: STARTED
[05:09:11.473] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:24:0) after 3m19s
[05:12:30.742] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:24:0)
[05:12:30.774] Build status: STARTED
[05:12:30.774] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:25:0) after 8m45s
[05:21:15.846] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:25:0)
[05:21:15.888] Build status: STARTED
[05:21:15.888] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:26:0) after 7m52s
[05:29:07.982] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:26:0)
[05:29:08.010] Build status: STARTED
[05:29:08.010] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:27:0) after 5m43s
[05:34:51.027] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:27:0)
[05:34:51.053] Build status: STARTED
[05:34:51.053] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:28:0) after 4m55s
[05:39:46.158] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:28:0)
[05:39:46.174] Build status: STARTED
[05:39:46.174] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:29:0) after 7m13s
[05:46:59.177] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:29:0)
[05:46:59.198] Build status: STARTED
[05:46:59.198] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:30:0) after 5m12s
[05:52:11.231] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:30:0)
[05:52:11.248] Build status: STARTED
[05:52:11.249] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:31:0) after 4m1s
[05:56:12.273] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:31:0)
[05:56:12.334] Build status: STARTED
[05:56:12.334] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:32:0) after 2m0s
[05:58:12.381] Handling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:32:0)
[05:58:12.428] Build status: STARTED
[05:58:12.428] Scheduling timer "check-buildbucket-build-status" (chromium-m145/win-official:8856170002860014144:33:0) after 9m41s
[06:01:09.915] Received PubSub notification, asking Buildbucket for the build status
[06:01:09.930] Build:
{
"id": "8690739931450618481",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "win-official"
},
"number": 173,
"createdBy": "project:chromium-m145",
"createTime": "2026-02-05T03:19:19.017613325Z",
"startTime": "2026-02-05T03:19:23.398046899Z",
"endTime": "2026-02-05T06:01:06.928555291Z",
"updateTime": "2026-02-05T06:01:06.928555291Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b87f84dee49ab4431ca86bda6d75ad9ce7f245bd",
"ref": "refs/branch-heads/7632"
}
}
}
[06:01:09.930] Invocation finished in 2h42m1.178038077s with status SUCCEEDED