[18:00:57.301] New invocation is queued and will start shortly
[18:00:58.603] Starting the invocation (attempt 1)
[18:00:58.632] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/622bb291b10f0d370b72c66d1fdf2d0d9ea47a02"
[18:00:58.632] Popped gitiles commit info from properties and tags
[18:00:58.632] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:00:58.632] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:00:58.632] Buildbucket request:
{
"requestId": "8866804966276916928",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8866804966276916928",
"job": "chromium-m140/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "773fb8bac080c988ea29de0dd72059409bf3e6fd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@773fb8bac080c988ea29de0dd72059409bf3e6fd",
"title": "773fb8bac080c988ea29de0dd72059409bf3e6fd",
"url": "https://chromium.googlesource.com/chromium/src/+/773fb8bac080c988ea29de0dd72059409bf3e6fd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4cd96e20c425cf188b4346d271a0868a73adf333"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@4cd96e20c425cf188b4346d271a0868a73adf333",
"title": "4cd96e20c425cf188b4346d271a0868a73adf333",
"url": "https://chromium.googlesource.com/chromium/src/+/4cd96e20c425cf188b4346d271a0868a73adf333"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "107b4d70f4aa1c32a7c0c347743bf3d93cf5a4f9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@107b4d70f4aa1c32a7c0c347743bf3d93cf5a4f9",
"title": "107b4d70f4aa1c32a7c0c347743bf3d93cf5a4f9",
"url": "https://chromium.googlesource.com/chromium/src/+/107b4d70f4aa1c32a7c0c347743bf3d93cf5a4f9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0034fbbd6bf58e2ab733722dc5d1cb90b7de6fff"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@0034fbbd6bf58e2ab733722dc5d1cb90b7de6fff",
"title": "0034fbbd6bf58e2ab733722dc5d1cb90b7de6fff",
"url": "https://chromium.googlesource.com/chromium/src/+/0034fbbd6bf58e2ab733722dc5d1cb90b7de6fff"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6ce7c73c7bf9cad29613d2d441336be14fb8232b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@6ce7c73c7bf9cad29613d2d441336be14fb8232b",
"title": "6ce7c73c7bf9cad29613d2d441336be14fb8232b",
"url": "https://chromium.googlesource.com/chromium/src/+/6ce7c73c7bf9cad29613d2d441336be14fb8232b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "116456ef181a2e41a005e66222c294a60fbc9003"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@116456ef181a2e41a005e66222c294a60fbc9003",
"title": "116456ef181a2e41a005e66222c294a60fbc9003",
"url": "https://chromium.googlesource.com/chromium/src/+/116456ef181a2e41a005e66222c294a60fbc9003"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "622bb291b10f0d370b72c66d1fdf2d0d9ea47a02"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@622bb291b10f0d370b72c66d1fdf2d0d9ea47a02",
"title": "622bb291b10f0d370b72c66d1fdf2d0d9ea47a02",
"url": "https://chromium.googlesource.com/chromium/src/+/622bb291b10f0d370b72c66d1fdf2d0d9ea47a02"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "622bb291b10f0d370b72c66d1fdf2d0d9ea47a02",
"ref": "refs/branch-heads/7339"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8866804966276916928"
},
{
"key": "scheduler_job_id",
"value": "chromium-m140/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:00:59.175] Scheduled build:
{
"id": "8701374904151702401",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 719,
"createdBy": "project:chromium-m140",
"createTime": "2025-10-10T18:00:58.696531378Z",
"updateTime": "2025-10-10T18:00:58.696531378Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "622bb291b10f0d370b72c66d1fdf2d0d9ea47a02",
"ref": "refs/branch-heads/7339"
}
}
}
[18:00:59.175] Task URL: https://cr-buildbucket.appspot.com/build/8701374904151702401
[18:00:59.175] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:2:0) after 9m9s
[18:01:00.175] Received PubSub notification, asking Buildbucket for the build status
[18:01:00.202] Build status: SCHEDULED
[18:01:12.169] Received PubSub notification, asking Buildbucket for the build status
[18:01:12.188] Build status: STARTED
[18:10:08.300] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:2:0)
[18:10:08.332] Build status: STARTED
[18:10:08.332] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:5:0) after 7m47s
[18:17:55.379] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:5:0)
[18:17:55.398] Build status: STARTED
[18:17:55.398] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:6:0) after 8m43s
[18:26:38.522] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:6:0)
[18:26:38.552] Build status: STARTED
[18:26:38.552] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:7:0) after 1m42s
[18:28:20.566] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:7:0)
[18:28:20.593] Build status: STARTED
[18:28:20.593] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:8:0) after 3m38s
[18:31:58.561] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:8:0)
[18:31:58.584] Build status: STARTED
[18:31:58.584] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:9:0) after 5m32s
[18:37:30.577] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:9:0)
[18:37:30.592] Build status: STARTED
[18:37:30.592] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:10:0) after 9m48s
[18:47:18.618] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:10:0)
[18:47:18.637] Build status: STARTED
[18:47:18.637] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:11:0) after 9m33s
[18:56:51.679] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:11:0)
[18:56:51.695] Build status: STARTED
[18:56:51.695] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:12:0) after 3m51s
[19:00:42.752] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:12:0)
[19:00:42.772] Build status: STARTED
[19:00:42.772] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:13:0) after 9m51s
[19:10:33.907] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:13:0)
[19:10:33.924] Build status: STARTED
[19:10:33.924] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:14:0) after 7m8s
[19:17:42.050] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:14:0)
[19:17:42.066] Build status: STARTED
[19:17:42.066] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:15:0) after 8m36s
[19:26:18.152] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:15:0)
[19:26:18.182] Build status: STARTED
[19:26:18.182] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:16:0) after 2m15s
[19:28:33.214] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:16:0)
[19:28:33.238] Build status: STARTED
[19:28:33.238] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:17:0) after 8m45s
[19:37:18.272] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:17:0)
[19:37:18.354] Build status: STARTED
[19:37:18.354] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:18:0) after 5m47s
[19:43:05.369] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:18:0)
[19:43:05.395] Build status: STARTED
[19:43:05.395] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:19:0) after 7m28s
[19:50:33.414] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:19:0)
[19:50:33.431] Build status: STARTED
[19:50:33.431] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:20:0) after 8m19s
[19:58:52.548] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:20:0)
[19:58:52.570] Build status: STARTED
[19:58:52.570] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:21:0) after 1m36s
[20:00:28.544] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:21:0)
[20:00:28.578] Build status: STARTED
[20:00:28.578] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:22:0) after 1m43s
[20:02:11.610] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:22:0)
[20:02:11.669] Build status: STARTED
[20:02:11.670] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:23:0) after 7m50s
[20:10:01.802] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:23:0)
[20:10:01.819] Build status: STARTED
[20:10:01.819] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:24:0) after 2m58s
[20:12:59.887] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:24:0)
[20:12:59.906] Build status: STARTED
[20:12:59.906] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:25:0) after 6m28s
[20:19:28.239] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:25:0)
[20:19:28.257] Build status: STARTED
[20:19:28.257] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:26:0) after 4m51s
[20:24:19.271] Handling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:26:0)
[20:24:19.286] Build status: STARTED
[20:24:19.286] Scheduling timer "check-buildbucket-build-status" (chromium-m140/win-arm64-rel:8866804966276916928:27:0) after 9m5s
[20:25:08.924] Received PubSub notification, asking Buildbucket for the build status
[20:25:08.940] Build:
{
"id": "8701374904151702401",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 719,
"createdBy": "project:chromium-m140",
"createTime": "2025-10-10T18:00:58.696531378Z",
"startTime": "2025-10-10T18:01:11.382388478Z",
"endTime": "2025-10-10T20:25:08.600759799Z",
"updateTime": "2025-10-10T20:25:08.600759799Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "622bb291b10f0d370b72c66d1fdf2d0d9ea47a02",
"ref": "refs/branch-heads/7339"
}
}
}
[20:25:08.940] Invocation finished in 2h24m11.653356738s with status SUCCEEDED