[18:40:26.591] New invocation is queued and will start shortly
[18:40:27.639] Starting the invocation (attempt 1)
[18:40:27.660] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a58c3510bda56512c1b5ad481da926c9e8928884"
[18:40:27.660] Popped gitiles commit info from properties and tags
[18:40:27.660] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:40:27.660] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:40:27.661] Buildbucket request:
{
"requestId": "8851491594564632272",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851491594564632272",
"job": "chromium-m147/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "17daaf2f3cf00aaa7ee18af7373d8eb9a875e116"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@17daaf2f3cf00aaa7ee18af7373d8eb9a875e116",
"title": "17daaf2f3cf00aaa7ee18af7373d8eb9a875e116",
"url": "https://chromium.googlesource.com/chromium/src/+/17daaf2f3cf00aaa7ee18af7373d8eb9a875e116"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "235cc7d0a828420cc8362e5796e6765e42723df5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@235cc7d0a828420cc8362e5796e6765e42723df5",
"title": "235cc7d0a828420cc8362e5796e6765e42723df5",
"url": "https://chromium.googlesource.com/chromium/src/+/235cc7d0a828420cc8362e5796e6765e42723df5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d6bac575e6c1f05f5804f9138233e7decffe4087"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@d6bac575e6c1f05f5804f9138233e7decffe4087",
"title": "d6bac575e6c1f05f5804f9138233e7decffe4087",
"url": "https://chromium.googlesource.com/chromium/src/+/d6bac575e6c1f05f5804f9138233e7decffe4087"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "485a2e256c5c13f14a1f0a27670c95eb517ccc8c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@485a2e256c5c13f14a1f0a27670c95eb517ccc8c",
"title": "485a2e256c5c13f14a1f0a27670c95eb517ccc8c",
"url": "https://chromium.googlesource.com/chromium/src/+/485a2e256c5c13f14a1f0a27670c95eb517ccc8c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2cca979b8fec120e2b3aea90ccb5be3c393925ff"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@2cca979b8fec120e2b3aea90ccb5be3c393925ff",
"title": "2cca979b8fec120e2b3aea90ccb5be3c393925ff",
"url": "https://chromium.googlesource.com/chromium/src/+/2cca979b8fec120e2b3aea90ccb5be3c393925ff"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a58c3510bda56512c1b5ad481da926c9e8928884"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@a58c3510bda56512c1b5ad481da926c9e8928884",
"title": "a58c3510bda56512c1b5ad481da926c9e8928884",
"url": "https://chromium.googlesource.com/chromium/src/+/a58c3510bda56512c1b5ad481da926c9e8928884"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a58c3510bda56512c1b5ad481da926c9e8928884",
"ref": "refs/branch-heads/7727"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851491594564632272"
},
{
"key": "scheduler_job_id",
"value": "chromium-m147/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:40:28.133] Scheduled build:
{
"id": "8686061532735804705",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 171,
"createdBy": "project:chromium-m147",
"createTime": "2026-03-28T18:40:27.713994672Z",
"updateTime": "2026-03-28T18:40:27.713994672Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a58c3510bda56512c1b5ad481da926c9e8928884",
"ref": "refs/branch-heads/7727"
}
}
}
[18:40:28.133] Task URL: https://cr-buildbucket.appspot.com/build/8686061532735804705
[18:40:28.133] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:2:0) after 8m18s
[18:40:28.370] Received PubSub notification, asking Buildbucket for the build status
[18:40:28.390] Build status: SCHEDULED
[18:40:36.057] Received PubSub notification, asking Buildbucket for the build status
[18:40:36.087] Build status: STARTED
[18:48:46.147] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:2:0)
[18:48:46.164] Build status: STARTED
[18:48:46.164] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:5:0) after 3m11s
[18:51:57.427] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:5:0)
[18:51:57.446] Build status: STARTED
[18:51:57.446] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:6:0) after 4m21s
[18:56:18.527] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:6:0)
[18:56:18.548] Build status: STARTED
[18:56:18.548] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:7:0) after 8m18s
[19:04:36.815] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:7:0)
[19:04:36.836] Build status: STARTED
[19:04:36.836] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:8:0) after 1m3s
[19:05:39.849] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:8:0)
[19:05:39.877] Build status: STARTED
[19:05:39.877] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:9:0) after 4m11s
[19:09:50.991] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:9:0)
[19:09:51.008] Build status: STARTED
[19:09:51.008] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:10:0) after 4m38s
[19:14:29.165] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:10:0)
[19:14:29.191] Build status: STARTED
[19:14:29.191] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:11:0) after 6m58s
[19:21:27.299] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:11:0)
[19:21:27.367] Build status: STARTED
[19:21:27.367] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:12:0) after 2m16s
[19:23:43.516] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:12:0)
[19:23:43.537] Build status: STARTED
[19:23:43.537] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:13:0) after 5m6s
[19:28:49.843] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:13:0)
[19:28:49.865] Build status: STARTED
[19:28:49.865] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:14:0) after 7m51s
[19:36:40.979] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:14:0)
[19:36:40.992] Build status: STARTED
[19:36:40.992] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:15:0) after 7m23s
[19:44:04.007] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:15:0)
[19:44:04.034] Build status: STARTED
[19:44:04.034] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:16:0) after 5m19s
[19:49:23.056] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:16:0)
[19:49:23.091] Build status: STARTED
[19:49:23.091] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:17:0) after 4m28s
[19:53:51.205] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:17:0)
[19:53:51.225] Build status: STARTED
[19:53:51.225] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:18:0) after 1m39s
[19:55:30.334] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:18:0)
[19:55:30.354] Build status: STARTED
[19:55:30.354] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:19:0) after 2m31s
[19:58:01.372] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:19:0)
[19:58:01.392] Build status: STARTED
[19:58:01.392] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:20:0) after 5m43s
[20:03:44.407] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:20:0)
[20:03:44.433] Build status: STARTED
[20:03:44.433] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:21:0) after 1m47s
[20:05:31.492] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:21:0)
[20:05:31.522] Build status: STARTED
[20:05:31.522] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:22:0) after 1m14s
[20:06:45.537] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:22:0)
[20:06:45.555] Build status: STARTED
[20:06:45.555] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:23:0) after 3m26s
[20:10:11.572] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:23:0)
[20:10:11.751] Build status: STARTED
[20:10:11.751] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:24:0) after 9m42s
[20:19:53.769] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:24:0)
[20:19:53.787] Build status: STARTED
[20:19:53.787] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:25:0) after 8m36s
[20:28:29.905] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:25:0)
[20:28:29.928] Build status: STARTED
[20:28:29.929] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:26:0) after 8m55s
[20:37:25.134] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:26:0)
[20:37:25.147] Build status: STARTED
[20:37:25.147] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:27:0) after 3m50s
[20:41:15.165] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:27:0)
[20:41:15.319] Build status: STARTED
[20:41:15.319] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:28:0) after 4m8s
[20:45:23.691] Handling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:28:0)
[20:45:23.722] Build status: STARTED
[20:45:23.722] Scheduling timer "check-buildbucket-build-status" (chromium-m147/win-arm64-rel:8851491594564632272:29:0) after 9m17s
[20:49:17.280] Received PubSub notification, asking Buildbucket for the build status
[20:49:17.303] Build:
{
"id": "8686061532735804705",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 171,
"createdBy": "project:chromium-m147",
"createTime": "2026-03-28T18:40:27.713994672Z",
"startTime": "2026-03-28T18:40:34.854719058Z",
"endTime": "2026-03-28T20:49:16.940597915Z",
"updateTime": "2026-03-28T20:49:16.940597915Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a58c3510bda56512c1b5ad481da926c9e8928884",
"ref": "refs/branch-heads/7727"
}
}
}
[20:49:17.303] Invocation finished in 2h8m50.717402521s with status SUCCEEDED