[00:39:06.767] New invocation is queued and will start shortly
[00:39:07.886] Starting the invocation (attempt 1)
[00:39:07.908] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7da2d643d32ab93207ecf63e281dfead48635eb"
[00:39:07.908] Popped gitiles commit info from properties and tags
[00:39:07.908] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:39:07.908] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:39:07.908] Buildbucket request:
{
"requestId": "8859441562068516336",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8859441562068516336",
"job": "chromium-m144/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa5dbe1794c52ae9a3313df1aa5429d97a8aee39"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@aa5dbe1794c52ae9a3313df1aa5429d97a8aee39",
"title": "aa5dbe1794c52ae9a3313df1aa5429d97a8aee39",
"url": "https://chromium.googlesource.com/chromium/src/+/aa5dbe1794c52ae9a3313df1aa5429d97a8aee39"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d581e5f04724679b60ad3b0bdf1e4dc6fcdef555"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@d581e5f04724679b60ad3b0bdf1e4dc6fcdef555",
"title": "d581e5f04724679b60ad3b0bdf1e4dc6fcdef555",
"url": "https://chromium.googlesource.com/chromium/src/+/d581e5f04724679b60ad3b0bdf1e4dc6fcdef555"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e253e946448685bbc80fabcae783c64fa1738d15"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@e253e946448685bbc80fabcae783c64fa1738d15",
"title": "e253e946448685bbc80fabcae783c64fa1738d15",
"url": "https://chromium.googlesource.com/chromium/src/+/e253e946448685bbc80fabcae783c64fa1738d15"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4c3e3cf3ba0a6a9d821f43969ea7a52702d30a65"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@4c3e3cf3ba0a6a9d821f43969ea7a52702d30a65",
"title": "4c3e3cf3ba0a6a9d821f43969ea7a52702d30a65",
"url": "https://chromium.googlesource.com/chromium/src/+/4c3e3cf3ba0a6a9d821f43969ea7a52702d30a65"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4b61cfae6497dec54e52041f00ddac2ca3b6b615"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@4b61cfae6497dec54e52041f00ddac2ca3b6b615",
"title": "4b61cfae6497dec54e52041f00ddac2ca3b6b615",
"url": "https://chromium.googlesource.com/chromium/src/+/4b61cfae6497dec54e52041f00ddac2ca3b6b615"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "08c8cab3b4930fedb87c4fb15950123141c4eefd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@08c8cab3b4930fedb87c4fb15950123141c4eefd",
"title": "08c8cab3b4930fedb87c4fb15950123141c4eefd",
"url": "https://chromium.googlesource.com/chromium/src/+/08c8cab3b4930fedb87c4fb15950123141c4eefd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "87720805cbd071f6ea03adb92f93497cfa937a42"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@87720805cbd071f6ea03adb92f93497cfa937a42",
"title": "87720805cbd071f6ea03adb92f93497cfa937a42",
"url": "https://chromium.googlesource.com/chromium/src/+/87720805cbd071f6ea03adb92f93497cfa937a42"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e7e46bc7dd582f53f3128e87b3bf9dc7101e6a52"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@e7e46bc7dd582f53f3128e87b3bf9dc7101e6a52",
"title": "e7e46bc7dd582f53f3128e87b3bf9dc7101e6a52",
"url": "https://chromium.googlesource.com/chromium/src/+/e7e46bc7dd582f53f3128e87b3bf9dc7101e6a52"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9c6da39f22877a7ac64dd5ee208d5eca06595872"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@9c6da39f22877a7ac64dd5ee208d5eca06595872",
"title": "9c6da39f22877a7ac64dd5ee208d5eca06595872",
"url": "https://chromium.googlesource.com/chromium/src/+/9c6da39f22877a7ac64dd5ee208d5eca06595872"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4c06005ea132d3166d55e9d955334ed16b7ea0b7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@4c06005ea132d3166d55e9d955334ed16b7ea0b7",
"title": "4c06005ea132d3166d55e9d955334ed16b7ea0b7",
"url": "https://chromium.googlesource.com/chromium/src/+/4c06005ea132d3166d55e9d955334ed16b7ea0b7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bfb602d676bf9641c14a28af6658c33241717160"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@bfb602d676bf9641c14a28af6658c33241717160",
"title": "bfb602d676bf9641c14a28af6658c33241717160",
"url": "https://chromium.googlesource.com/chromium/src/+/bfb602d676bf9641c14a28af6658c33241717160"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a466e940b9d0c5cc32f21a8c7db414a8f02b4337"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@a466e940b9d0c5cc32f21a8c7db414a8f02b4337",
"title": "a466e940b9d0c5cc32f21a8c7db414a8f02b4337",
"url": "https://chromium.googlesource.com/chromium/src/+/a466e940b9d0c5cc32f21a8c7db414a8f02b4337"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0a8b90607bc39c3e508ea1ff1cd982f939788ff1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@0a8b90607bc39c3e508ea1ff1cd982f939788ff1",
"title": "0a8b90607bc39c3e508ea1ff1cd982f939788ff1",
"url": "https://chromium.googlesource.com/chromium/src/+/0a8b90607bc39c3e508ea1ff1cd982f939788ff1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "58fe746a6eecf259bf0eddd1fa961fa81c63d731"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@58fe746a6eecf259bf0eddd1fa961fa81c63d731",
"title": "58fe746a6eecf259bf0eddd1fa961fa81c63d731",
"url": "https://chromium.googlesource.com/chromium/src/+/58fe746a6eecf259bf0eddd1fa961fa81c63d731"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "519b3ce09180255e2d1629ef698881bcb5dbb9bf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@519b3ce09180255e2d1629ef698881bcb5dbb9bf",
"title": "519b3ce09180255e2d1629ef698881bcb5dbb9bf",
"url": "https://chromium.googlesource.com/chromium/src/+/519b3ce09180255e2d1629ef698881bcb5dbb9bf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "45c3560a20c8ef78ab087bb5630d4b91f1dc0d4a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@45c3560a20c8ef78ab087bb5630d4b91f1dc0d4a",
"title": "45c3560a20c8ef78ab087bb5630d4b91f1dc0d4a",
"url": "https://chromium.googlesource.com/chromium/src/+/45c3560a20c8ef78ab087bb5630d4b91f1dc0d4a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "99d95312054cf738591eebc443218d672b33fec7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@99d95312054cf738591eebc443218d672b33fec7",
"title": "99d95312054cf738591eebc443218d672b33fec7",
"url": "https://chromium.googlesource.com/chromium/src/+/99d95312054cf738591eebc443218d672b33fec7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d7da2d643d32ab93207ecf63e281dfead48635eb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@d7da2d643d32ab93207ecf63e281dfead48635eb",
"title": "d7da2d643d32ab93207ecf63e281dfead48635eb",
"url": "https://chromium.googlesource.com/chromium/src/+/d7da2d643d32ab93207ecf63e281dfead48635eb"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d7da2d643d32ab93207ecf63e281dfead48635eb",
"ref": "refs/branch-heads/7559"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8859441562068516336"
},
{
"key": "scheduler_job_id",
"value": "chromium-m144/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:39:08.493] Scheduled build:
{
"id": "8694011500170430481",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 282,
"createdBy": "project:chromium-m144",
"createTime": "2025-12-31T00:39:07.954853472Z",
"updateTime": "2025-12-31T00:39:07.954853472Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d7da2d643d32ab93207ecf63e281dfead48635eb",
"ref": "refs/branch-heads/7559"
}
}
}
[00:39:08.493] Task URL: https://cr-buildbucket.appspot.com/build/8694011500170430481
[00:39:08.493] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:2:0) after 8m18s
[00:39:12.626] Received PubSub notification, asking Buildbucket for the build status
[00:39:12.641] Build status: SCHEDULED
[00:39:23.152] Received PubSub notification, asking Buildbucket for the build status
[00:39:23.177] Build status: STARTED
[00:47:26.508] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:2:0)
[00:47:26.527] Build status: STARTED
[00:47:26.527] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:5:0) after 3m8s
[00:50:34.541] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:5:0)
[00:50:34.553] Build status: STARTED
[00:50:34.553] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:6:0) after 9m38s
[01:00:12.619] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:6:0)
[01:00:12.649] Build status: STARTED
[01:00:12.649] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:7:0) after 7m51s
[01:08:03.666] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:7:0)
[01:08:03.717] Build status: STARTED
[01:08:03.717] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:8:0) after 3m29s
[01:11:32.730] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:8:0)
[01:11:32.744] Build status: STARTED
[01:11:32.744] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:9:0) after 2m50s
[01:14:22.861] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:9:0)
[01:14:22.897] Build status: STARTED
[01:14:22.897] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:10:0) after 9m57s
[01:24:19.911] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:10:0)
[01:24:19.925] Build status: STARTED
[01:24:19.925] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:11:0) after 8m58s
[01:33:17.974] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:11:0)
[01:33:17.999] Build status: STARTED
[01:33:17.999] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:12:0) after 2m48s
[01:36:06.018] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:12:0)
[01:36:06.084] Build status: STARTED
[01:36:06.084] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:13:0) after 4m13s
[01:40:19.138] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:13:0)
[01:40:19.164] Build status: STARTED
[01:40:19.164] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:14:0) after 4m15s
[01:44:34.183] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:14:0)
[01:44:34.203] Build status: STARTED
[01:44:34.203] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:15:0) after 3m36s
[01:48:10.640] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:15:0)
[01:48:10.681] Build status: STARTED
[01:48:10.681] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:16:0) after 8m6s
[01:56:16.695] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:16:0)
[01:56:16.729] Build status: STARTED
[01:56:16.729] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:17:0) after 5m39s
[02:01:56.254] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:17:0)
[02:01:56.289] Build status: STARTED
[02:01:56.289] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:18:0) after 4m22s
[02:06:18.693] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:18:0)
[02:06:18.709] Build status: STARTED
[02:06:18.709] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:19:0) after 5m41s
[02:11:59.720] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:19:0)
[02:11:59.733] Build status: STARTED
[02:11:59.733] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:20:0) after 4m54s
[02:16:53.757] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:20:0)
[02:16:53.773] Build status: STARTED
[02:16:53.773] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:21:0) after 6m42s
[02:23:35.812] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:21:0)
[02:23:35.826] Build status: STARTED
[02:23:35.826] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:22:0) after 8m17s
[02:31:53.145] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:22:0)
[02:31:53.170] Build status: STARTED
[02:31:53.170] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:23:0) after 5m11s
[02:37:04.684] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:23:0)
[02:37:04.700] Build status: STARTED
[02:37:04.700] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:24:0) after 7m20s
[02:44:24.718] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:24:0)
[02:44:24.791] Build status: STARTED
[02:44:24.791] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:25:0) after 7m40s
[02:52:05.345] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:25:0)
[02:52:05.359] Build status: STARTED
[02:52:05.359] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:26:0) after 2m26s
[02:54:31.530] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:26:0)
[02:54:31.548] Build status: STARTED
[02:54:31.548] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:27:0) after 1m28s
[02:55:59.564] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:27:0)
[02:55:59.579] Build status: STARTED
[02:55:59.580] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:28:0) after 6m20s
[03:02:19.603] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:28:0)
[03:02:19.641] Build status: STARTED
[03:02:19.642] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:29:0) after 8m15s
[03:10:34.839] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:29:0)
[03:10:34.987] Build status: STARTED
[03:10:34.987] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:30:0) after 3m12s
[03:13:47.314] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:30:0)
[03:13:47.357] Build status: STARTED
[03:13:47.357] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:31:0) after 7m51s
[03:21:38.610] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:31:0)
[03:21:38.635] Build status: STARTED
[03:21:38.635] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:32:0) after 5m33s
[03:27:11.653] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:32:0)
[03:27:11.672] Build status: STARTED
[03:27:11.672] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:33:0) after 5m0s
[03:32:11.696] Handling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:33:0)
[03:32:11.717] Build status: STARTED
[03:32:11.717] Scheduling timer "check-buildbucket-build-status" (chromium-m144/win-arm64-rel:8859441562068516336:34:0) after 4m47s
[03:33:07.160] Received PubSub notification, asking Buildbucket for the build status
[03:33:07.178] Build:
{
"id": "8694011500170430481",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 282,
"createdBy": "project:chromium-m144",
"createTime": "2025-12-31T00:39:07.954853472Z",
"startTime": "2025-12-31T00:39:14.614216585Z",
"endTime": "2025-12-31T03:33:06.615318366Z",
"updateTime": "2025-12-31T03:33:06.615318366Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d7da2d643d32ab93207ecf63e281dfead48635eb",
"ref": "refs/branch-heads/7559"
}
}
}
[03:33:07.178] Invocation finished in 2h54m0.417425913s with status SUCCEEDED