[02:54:10.751] New invocation is queued and will start shortly
[02:54:12.070] Starting the invocation (attempt 1)
[02:54:12.095] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7dc6056a1a046be868da299027c59be7050332b2"
[02:54:12.095] Popped gitiles commit info from properties and tags
[02:54:12.095] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:54:12.095] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:54:12.096] Buildbucket request:
{
"requestId": "8864506494551809904",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8864506494551809904",
"job": "chromium-m143/win-arm64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bca3a631145d6e5136a520243f9971b6d51c23a9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@bca3a631145d6e5136a520243f9971b6d51c23a9",
"title": "bca3a631145d6e5136a520243f9971b6d51c23a9",
"url": "https://chromium.googlesource.com/chromium/src/+/bca3a631145d6e5136a520243f9971b6d51c23a9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "68bf5b83e64eef44a463665b33035316b82d5c80"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@68bf5b83e64eef44a463665b33035316b82d5c80",
"title": "68bf5b83e64eef44a463665b33035316b82d5c80",
"url": "https://chromium.googlesource.com/chromium/src/+/68bf5b83e64eef44a463665b33035316b82d5c80"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "64ccf4fb1db62349e9d3328f033a2d0401967acb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@64ccf4fb1db62349e9d3328f033a2d0401967acb",
"title": "64ccf4fb1db62349e9d3328f033a2d0401967acb",
"url": "https://chromium.googlesource.com/chromium/src/+/64ccf4fb1db62349e9d3328f033a2d0401967acb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8b361bba852105b4b3c6fc602186c1b247ba9b7e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@8b361bba852105b4b3c6fc602186c1b247ba9b7e",
"title": "8b361bba852105b4b3c6fc602186c1b247ba9b7e",
"url": "https://chromium.googlesource.com/chromium/src/+/8b361bba852105b4b3c6fc602186c1b247ba9b7e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "09d4d0f91273df5a6d626199d10eec8f592d9ec5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@09d4d0f91273df5a6d626199d10eec8f592d9ec5",
"title": "09d4d0f91273df5a6d626199d10eec8f592d9ec5",
"url": "https://chromium.googlesource.com/chromium/src/+/09d4d0f91273df5a6d626199d10eec8f592d9ec5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "29dbaf5274859f6806ee4c8a94b250a047475ec2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@29dbaf5274859f6806ee4c8a94b250a047475ec2",
"title": "29dbaf5274859f6806ee4c8a94b250a047475ec2",
"url": "https://chromium.googlesource.com/chromium/src/+/29dbaf5274859f6806ee4c8a94b250a047475ec2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "800ea0fb230553eb607369df0a9a8cdcd5e7ec75"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@800ea0fb230553eb607369df0a9a8cdcd5e7ec75",
"title": "800ea0fb230553eb607369df0a9a8cdcd5e7ec75",
"url": "https://chromium.googlesource.com/chromium/src/+/800ea0fb230553eb607369df0a9a8cdcd5e7ec75"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4861ea3171571647637ea35476ab79680822b9b0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@4861ea3171571647637ea35476ab79680822b9b0",
"title": "4861ea3171571647637ea35476ab79680822b9b0",
"url": "https://chromium.googlesource.com/chromium/src/+/4861ea3171571647637ea35476ab79680822b9b0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cce53a8ab6dc7d966812faf91370ca7f925e538c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@cce53a8ab6dc7d966812faf91370ca7f925e538c",
"title": "cce53a8ab6dc7d966812faf91370ca7f925e538c",
"url": "https://chromium.googlesource.com/chromium/src/+/cce53a8ab6dc7d966812faf91370ca7f925e538c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9eb290f48a5fc12cc72401b377600340a870a94d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@9eb290f48a5fc12cc72401b377600340a870a94d",
"title": "9eb290f48a5fc12cc72401b377600340a870a94d",
"url": "https://chromium.googlesource.com/chromium/src/+/9eb290f48a5fc12cc72401b377600340a870a94d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "56b07c178ac43488e57063ba5499ead31dbd8432"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@56b07c178ac43488e57063ba5499ead31dbd8432",
"title": "56b07c178ac43488e57063ba5499ead31dbd8432",
"url": "https://chromium.googlesource.com/chromium/src/+/56b07c178ac43488e57063ba5499ead31dbd8432"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b794707c80574271de488a80106f6d1235ca0ac8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@b794707c80574271de488a80106f6d1235ca0ac8",
"title": "b794707c80574271de488a80106f6d1235ca0ac8",
"url": "https://chromium.googlesource.com/chromium/src/+/b794707c80574271de488a80106f6d1235ca0ac8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "050dc49ca9affc4b42456cfefbbc3af70efaba0d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@050dc49ca9affc4b42456cfefbbc3af70efaba0d",
"title": "050dc49ca9affc4b42456cfefbbc3af70efaba0d",
"url": "https://chromium.googlesource.com/chromium/src/+/050dc49ca9affc4b42456cfefbbc3af70efaba0d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b21e77052d5513f2528be51eb3d48e1617efd9ec"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@b21e77052d5513f2528be51eb3d48e1617efd9ec",
"title": "b21e77052d5513f2528be51eb3d48e1617efd9ec",
"url": "https://chromium.googlesource.com/chromium/src/+/b21e77052d5513f2528be51eb3d48e1617efd9ec"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "71455b3d5a95577f13ae43e16c5b7dc1b150c36d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@71455b3d5a95577f13ae43e16c5b7dc1b150c36d",
"title": "71455b3d5a95577f13ae43e16c5b7dc1b150c36d",
"url": "https://chromium.googlesource.com/chromium/src/+/71455b3d5a95577f13ae43e16c5b7dc1b150c36d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6fcb5da90e9bb704d002d864bb40f6ddf8139ead"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@6fcb5da90e9bb704d002d864bb40f6ddf8139ead",
"title": "6fcb5da90e9bb704d002d864bb40f6ddf8139ead",
"url": "https://chromium.googlesource.com/chromium/src/+/6fcb5da90e9bb704d002d864bb40f6ddf8139ead"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7dc6056a1a046be868da299027c59be7050332b2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@7dc6056a1a046be868da299027c59be7050332b2",
"title": "7dc6056a1a046be868da299027c59be7050332b2",
"url": "https://chromium.googlesource.com/chromium/src/+/7dc6056a1a046be868da299027c59be7050332b2"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7dc6056a1a046be868da299027c59be7050332b2",
"ref": "refs/branch-heads/7499"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8864506494551809904"
},
{
"key": "scheduler_job_id",
"value": "chromium-m143/win-arm64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:54:12.591] Scheduled build:
{
"id": "8699076432416756001",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 79,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-05T02:54:12.157330987Z",
"updateTime": "2025-11-05T02:54:12.157330987Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7dc6056a1a046be868da299027c59be7050332b2",
"ref": "refs/branch-heads/7499"
}
}
}
[02:54:12.591] Task URL: https://cr-buildbucket.appspot.com/build/8699076432416756001
[02:54:12.591] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:2:0) after 4m53s
[02:54:13.533] Received PubSub notification, asking Buildbucket for the build status
[02:54:13.622] Build status: SCHEDULED
[02:54:18.065] Received PubSub notification, asking Buildbucket for the build status
[02:54:18.082] Build status: STARTED
[02:59:05.749] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:2:0)
[02:59:05.782] Build status: STARTED
[02:59:05.782] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:5:0) after 5m58s
[03:05:03.796] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:5:0)
[03:05:03.810] Build status: STARTED
[03:05:03.810] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:6:0) after 6m48s
[03:11:51.825] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:6:0)
[03:11:51.838] Build status: STARTED
[03:11:51.838] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:7:0) after 4m50s
[03:16:41.919] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:7:0)
[03:16:41.948] Build status: STARTED
[03:16:41.949] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:8:0) after 9m32s
[03:26:13.962] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:8:0)
[03:26:14.041] Build status: STARTED
[03:26:14.041] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:9:0) after 1m18s
[03:27:32.062] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:9:0)
[03:27:32.090] Build status: STARTED
[03:27:32.090] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:10:0) after 1m2s
[03:28:34.106] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:10:0)
[03:28:34.126] Build status: STARTED
[03:28:34.127] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:11:0) after 2m39s
[03:31:13.142] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:11:0)
[03:31:13.173] Build status: STARTED
[03:31:13.173] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:12:0) after 8m43s
[03:39:56.220] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:12:0)
[03:39:56.237] Build status: STARTED
[03:39:56.237] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:13:0) after 4m14s
[03:44:10.253] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:13:0)
[03:44:10.270] Build status: STARTED
[03:44:10.270] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:14:0) after 4m53s
[03:49:03.402] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:14:0)
[03:49:03.425] Build status: STARTED
[03:49:03.425] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:15:0) after 8m24s
[03:57:27.441] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:15:0)
[03:57:27.458] Build status: STARTED
[03:57:27.458] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:16:0) after 7m4s
[04:04:31.491] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:16:0)
[04:04:31.508] Build status: STARTED
[04:04:31.508] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:17:0) after 5m36s
[04:10:07.530] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:17:0)
[04:10:07.561] Build status: STARTED
[04:10:07.561] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:18:0) after 3m37s
[04:13:44.578] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:18:0)
[04:13:44.714] Build status: STARTED
[04:13:44.714] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:19:0) after 2m40s
[04:16:24.729] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:19:0)
[04:16:24.744] Build status: STARTED
[04:16:24.744] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:20:0) after 5m13s
[04:21:37.762] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:20:0)
[04:21:37.820] Build status: STARTED
[04:21:37.820] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:21:0) after 2m26s
[04:24:03.854] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:21:0)
[04:24:03.874] Build status: STARTED
[04:24:03.874] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:22:0) after 8m37s
[04:32:40.893] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:22:0)
[04:32:40.912] Build status: STARTED
[04:32:40.912] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:23:0) after 1m18s
[04:33:58.929] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:23:0)
[04:33:58.943] Build status: STARTED
[04:33:58.943] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:24:0) after 8m47s
[04:42:45.983] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:24:0)
[04:42:46.003] Build status: STARTED
[04:42:46.003] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:25:0) after 7m25s
[04:50:11.050] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:25:0)
[04:50:11.066] Build status: STARTED
[04:50:11.066] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:26:0) after 9m25s
[04:59:36.215] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:26:0)
[04:59:36.230] Build status: STARTED
[04:59:36.230] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:27:0) after 8m55s
[05:08:31.299] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:27:0)
[05:08:31.357] Build status: STARTED
[05:08:31.357] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:28:0) after 4m40s
[05:13:11.409] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:28:0)
[05:13:11.508] Build status: STARTED
[05:13:11.508] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:29:0) after 1m29s
[05:14:40.525] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:29:0)
[05:14:40.547] Build status: STARTED
[05:14:40.547] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:30:0) after 9m20s
[05:24:00.649] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:30:0)
[05:24:00.667] Build status: STARTED
[05:24:00.667] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:31:0) after 1m59s
[05:25:59.722] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:31:0)
[05:25:59.772] Build status: STARTED
[05:25:59.772] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:32:0) after 9m57s
[05:35:56.766] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:32:0)
[05:35:56.790] Build status: STARTED
[05:35:56.790] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:33:0) after 5m37s
[05:41:33.967] Handling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:33:0)
[05:41:33.991] Build status: STARTED
[05:41:33.991] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-arm64-rel:8864506494551809904:34:0) after 9m37s
[05:44:51.412] Received PubSub notification, asking Buildbucket for the build status
[05:44:51.436] Build:
{
"id": "8699076432416756001",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "win-arm64-rel"
},
"number": 79,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-05T02:54:12.157330987Z",
"startTime": "2025-11-05T02:54:17.902305373Z",
"endTime": "2025-11-05T05:44:24.341809120Z",
"updateTime": "2025-11-05T05:44:24.341809120Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7dc6056a1a046be868da299027c59be7050332b2",
"ref": "refs/branch-heads/7499"
}
}
}
[05:44:51.436] Invocation finished in 2h50m40.699220924s with status SUCCEEDED