[18:02:02.161] New invocation is queued and will start shortly
[18:02:03.246] Starting the invocation (attempt 1)
[18:02:03.289] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2df72af34c333a88a9222c3635ed82e0859362bf"
[18:02:03.289] Popped gitiles commit info from properties and tags
[18:02:03.289] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:02:03.290] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:02:03.291] Buildbucket request:
{
"requestId": "8850316250368898416",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8850316250368898416",
"job": "chromium-m148/win-arm64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fd4b161d9bd7a250e7dcacab0c1470a80fec4ed9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@fd4b161d9bd7a250e7dcacab0c1470a80fec4ed9",
"title": "fd4b161d9bd7a250e7dcacab0c1470a80fec4ed9",
"url": "https://chromium.googlesource.com/chromium/src/+/fd4b161d9bd7a250e7dcacab0c1470a80fec4ed9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5e4478a7dbc9c914f64026bf7c6b09502e97051a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5e4478a7dbc9c914f64026bf7c6b09502e97051a",
"title": "5e4478a7dbc9c914f64026bf7c6b09502e97051a",
"url": "https://chromium.googlesource.com/chromium/src/+/5e4478a7dbc9c914f64026bf7c6b09502e97051a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "45b9c87963d6a0800767ad546268d98415cb84c6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@45b9c87963d6a0800767ad546268d98415cb84c6",
"title": "45b9c87963d6a0800767ad546268d98415cb84c6",
"url": "https://chromium.googlesource.com/chromium/src/+/45b9c87963d6a0800767ad546268d98415cb84c6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e28da731a062718cc8230cbd5b39acd963eb68a0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@e28da731a062718cc8230cbd5b39acd963eb68a0",
"title": "e28da731a062718cc8230cbd5b39acd963eb68a0",
"url": "https://chromium.googlesource.com/chromium/src/+/e28da731a062718cc8230cbd5b39acd963eb68a0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b28c57d5b72bb24db5bc8d6ffe30b16242fec5d6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b28c57d5b72bb24db5bc8d6ffe30b16242fec5d6",
"title": "b28c57d5b72bb24db5bc8d6ffe30b16242fec5d6",
"url": "https://chromium.googlesource.com/chromium/src/+/b28c57d5b72bb24db5bc8d6ffe30b16242fec5d6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "69dd335573bed52f89360a1204b01988d9d9159d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@69dd335573bed52f89360a1204b01988d9d9159d",
"title": "69dd335573bed52f89360a1204b01988d9d9159d",
"url": "https://chromium.googlesource.com/chromium/src/+/69dd335573bed52f89360a1204b01988d9d9159d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6ab6a5c4f8a42718006f132ceabdb63676f6c1d5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@6ab6a5c4f8a42718006f132ceabdb63676f6c1d5",
"title": "6ab6a5c4f8a42718006f132ceabdb63676f6c1d5",
"url": "https://chromium.googlesource.com/chromium/src/+/6ab6a5c4f8a42718006f132ceabdb63676f6c1d5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e5107e20c9631a2fafc59e845c47539e92c0200a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@e5107e20c9631a2fafc59e845c47539e92c0200a",
"title": "e5107e20c9631a2fafc59e845c47539e92c0200a",
"url": "https://chromium.googlesource.com/chromium/src/+/e5107e20c9631a2fafc59e845c47539e92c0200a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "934e346fdad5718ca28be1c75360481f3674d195"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@934e346fdad5718ca28be1c75360481f3674d195",
"title": "934e346fdad5718ca28be1c75360481f3674d195",
"url": "https://chromium.googlesource.com/chromium/src/+/934e346fdad5718ca28be1c75360481f3674d195"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fbaab323d6b1f0add2cb7c897678f0d3cea6879b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@fbaab323d6b1f0add2cb7c897678f0d3cea6879b",
"title": "fbaab323d6b1f0add2cb7c897678f0d3cea6879b",
"url": "https://chromium.googlesource.com/chromium/src/+/fbaab323d6b1f0add2cb7c897678f0d3cea6879b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2df72af34c333a88a9222c3635ed82e0859362bf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@2df72af34c333a88a9222c3635ed82e0859362bf",
"title": "2df72af34c333a88a9222c3635ed82e0859362bf",
"url": "https://chromium.googlesource.com/chromium/src/+/2df72af34c333a88a9222c3635ed82e0859362bf"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2df72af34c333a88a9222c3635ed82e0859362bf",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8850316250368898416"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/win-arm64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:02:03.919] Scheduled build:
{
"id": "8684886188467171473",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-dbg"
},
"number": 51,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-10T18:02:03.355030909Z",
"updateTime": "2026-04-10T18:02:03.355030909Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2df72af34c333a88a9222c3635ed82e0859362bf",
"ref": "refs/branch-heads/7778"
}
}
}
[18:02:03.919] Task URL: https://cr-buildbucket.appspot.com/build/8684886188467171473
[18:02:03.919] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:2:0) after 2m41s
[18:02:04.008] Received PubSub notification, asking Buildbucket for the build status
[18:02:04.038] Build status: SCHEDULED
[18:02:08.468] Received PubSub notification, asking Buildbucket for the build status
[18:02:08.496] Build status: STARTED
[18:04:45.065] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:2:0)
[18:04:45.085] Build status: STARTED
[18:04:45.085] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:5:0) after 5m12s
[18:09:57.190] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:5:0)
[18:09:57.219] Build status: STARTED
[18:09:57.219] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:6:0) after 3m29s
[18:13:26.236] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:6:0)
[18:13:26.289] Build status: STARTED
[18:13:26.289] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:7:0) after 7m29s
[18:20:55.360] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:7:0)
[18:20:55.376] Build status: STARTED
[18:20:55.376] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:8:0) after 6m6s
[18:27:01.522] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:8:0)
[18:27:01.590] Build status: STARTED
[18:27:01.590] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:9:0) after 5m13s
[18:32:14.649] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:9:0)
[18:32:14.696] Build status: STARTED
[18:32:14.696] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:10:0) after 1m17s
[18:33:31.743] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:10:0)
[18:33:31.772] Build status: STARTED
[18:33:31.772] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:11:0) after 6m24s
[18:39:55.746] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:11:0)
[18:39:55.764] Build status: STARTED
[18:39:55.764] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:12:0) after 3m49s
[18:43:44.814] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:12:0)
[18:43:44.833] Build status: STARTED
[18:43:44.833] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:13:0) after 1m37s
[18:45:21.892] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:13:0)
[18:45:21.917] Build status: STARTED
[18:45:21.917] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:14:0) after 6m6s
[18:51:27.929] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:14:0)
[18:51:27.951] Build status: STARTED
[18:51:27.951] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:15:0) after 4m33s
[18:56:01.019] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:15:0)
[18:56:01.035] Build status: STARTED
[18:56:01.035] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:16:0) after 7m55s
[19:03:56.105] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:16:0)
[19:03:56.122] Build status: STARTED
[19:03:56.122] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:17:0) after 3m17s
[19:07:13.217] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:17:0)
[19:07:13.233] Build status: STARTED
[19:07:13.233] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:18:0) after 7m26s
[19:14:39.254] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:18:0)
[19:14:39.281] Build status: STARTED
[19:14:39.281] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:19:0) after 9m41s
[19:24:20.295] Handling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:19:0)
[19:24:20.311] Build status: STARTED
[19:24:20.311] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-arm64-dbg:8850316250368898416:20:0) after 9m23s
[19:27:16.125] Received PubSub notification, asking Buildbucket for the build status
[19:27:16.148] Build:
{
"id": "8684886188467171473",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-arm64-dbg"
},
"number": 51,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-10T18:02:03.355030909Z",
"startTime": "2026-04-10T18:02:08.289597228Z",
"endTime": "2026-04-10T19:27:15.855950161Z",
"updateTime": "2026-04-10T19:27:15.855950161Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2df72af34c333a88a9222c3635ed82e0859362bf",
"ref": "refs/branch-heads/7778"
}
}
}
[19:27:16.148] Invocation finished in 1h25m13.990484314s with status SUCCEEDED