[20:57:00.724] New invocation is queued and will start shortly
[20:57:01.800] Starting the invocation (attempt 1)
[20:57:01.835] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517"
[20:57:01.835] Popped gitiles commit info from properties and tags
[20:57:01.835] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:57:01.835] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:57:01.836] Buildbucket request:
{
"requestId": "8846047184408060848",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8846047184408060848",
"job": "chromium-m149/linux-cast-x64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7c3a68f0bd5490271ee5d98820ec029cf4428ad7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@7c3a68f0bd5490271ee5d98820ec029cf4428ad7",
"title": "7c3a68f0bd5490271ee5d98820ec029cf4428ad7",
"url": "https://chromium.googlesource.com/chromium/src/+/7c3a68f0bd5490271ee5d98820ec029cf4428ad7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d68c40235ca3b54fc41d3f2d35dc87c881d4845a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@d68c40235ca3b54fc41d3f2d35dc87c881d4845a",
"title": "d68c40235ca3b54fc41d3f2d35dc87c881d4845a",
"url": "https://chromium.googlesource.com/chromium/src/+/d68c40235ca3b54fc41d3f2d35dc87c881d4845a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "268b2c0117308fb78386dee602dec717c05d7ace"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@268b2c0117308fb78386dee602dec717c05d7ace",
"title": "268b2c0117308fb78386dee602dec717c05d7ace",
"url": "https://chromium.googlesource.com/chromium/src/+/268b2c0117308fb78386dee602dec717c05d7ace"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa930422e9fba44819574b7de5cf9ad7d17c46c5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@aa930422e9fba44819574b7de5cf9ad7d17c46c5",
"title": "aa930422e9fba44819574b7de5cf9ad7d17c46c5",
"url": "https://chromium.googlesource.com/chromium/src/+/aa930422e9fba44819574b7de5cf9ad7d17c46c5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cd6760999fa987094595b78f2fa7aa903b71afd0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@cd6760999fa987094595b78f2fa7aa903b71afd0",
"title": "cd6760999fa987094595b78f2fa7aa903b71afd0",
"url": "https://chromium.googlesource.com/chromium/src/+/cd6760999fa987094595b78f2fa7aa903b71afd0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7603703dd4e98de86ad6595fac83d2208fbd5f21"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@7603703dd4e98de86ad6595fac83d2208fbd5f21",
"title": "7603703dd4e98de86ad6595fac83d2208fbd5f21",
"url": "https://chromium.googlesource.com/chromium/src/+/7603703dd4e98de86ad6595fac83d2208fbd5f21"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c2ea9a349192e04fa06d31112860e7145c06cb39"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@c2ea9a349192e04fa06d31112860e7145c06cb39",
"title": "c2ea9a349192e04fa06d31112860e7145c06cb39",
"url": "https://chromium.googlesource.com/chromium/src/+/c2ea9a349192e04fa06d31112860e7145c06cb39"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bb7eb812c649c81b9461fb3eb3cccfd7e37c6a79"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@bb7eb812c649c81b9461fb3eb3cccfd7e37c6a79",
"title": "bb7eb812c649c81b9461fb3eb3cccfd7e37c6a79",
"url": "https://chromium.googlesource.com/chromium/src/+/bb7eb812c649c81b9461fb3eb3cccfd7e37c6a79"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2536aa516a854c998ff3ed21875e4a8de01e592d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@2536aa516a854c998ff3ed21875e4a8de01e592d",
"title": "2536aa516a854c998ff3ed21875e4a8de01e592d",
"url": "https://chromium.googlesource.com/chromium/src/+/2536aa516a854c998ff3ed21875e4a8de01e592d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d829cebc362a70c5e20649166c4ff33b2c9e27f7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@d829cebc362a70c5e20649166c4ff33b2c9e27f7",
"title": "d829cebc362a70c5e20649166c4ff33b2c9e27f7",
"url": "https://chromium.googlesource.com/chromium/src/+/d829cebc362a70c5e20649166c4ff33b2c9e27f7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "759bbb3e4117409f97e363b7cab705f54e8b42c7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@759bbb3e4117409f97e363b7cab705f54e8b42c7",
"title": "759bbb3e4117409f97e363b7cab705f54e8b42c7",
"url": "https://chromium.googlesource.com/chromium/src/+/759bbb3e4117409f97e363b7cab705f54e8b42c7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "30c95a6fa64a90170244a48f61e780b33db890d5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@30c95a6fa64a90170244a48f61e780b33db890d5",
"title": "30c95a6fa64a90170244a48f61e780b33db890d5",
"url": "https://chromium.googlesource.com/chromium/src/+/30c95a6fa64a90170244a48f61e780b33db890d5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9b7959793f8b2bd2436afc14f91ce410238496c2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@9b7959793f8b2bd2436afc14f91ce410238496c2",
"title": "9b7959793f8b2bd2436afc14f91ce410238496c2",
"url": "https://chromium.googlesource.com/chromium/src/+/9b7959793f8b2bd2436afc14f91ce410238496c2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7b3218350f3707475502cebd02ba65392f955d45"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@7b3218350f3707475502cebd02ba65392f955d45",
"title": "7b3218350f3707475502cebd02ba65392f955d45",
"url": "https://chromium.googlesource.com/chromium/src/+/7b3218350f3707475502cebd02ba65392f955d45"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7df551136695039790ba5ef773eb3ee4691eec23"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@7df551136695039790ba5ef773eb3ee4691eec23",
"title": "7df551136695039790ba5ef773eb3ee4691eec23",
"url": "https://chromium.googlesource.com/chromium/src/+/7df551136695039790ba5ef773eb3ee4691eec23"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6e5a66813401e433a8e7b022afa65ff8577318c7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@6e5a66813401e433a8e7b022afa65ff8577318c7",
"title": "6e5a66813401e433a8e7b022afa65ff8577318c7",
"url": "https://chromium.googlesource.com/chromium/src/+/6e5a66813401e433a8e7b022afa65ff8577318c7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517",
"title": "3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517",
"url": "https://chromium.googlesource.com/chromium/src/+/3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517",
"ref": "refs/branch-heads/7827"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8846047184408060848"
},
{
"key": "scheduler_job_id",
"value": "chromium-m149/linux-cast-x64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:57:02.399] Scheduled build:
{
"id": "8680617122511435137",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 316,
"createdBy": "project:chromium-m149",
"createTime": "2026-05-27T20:57:01.912356099Z",
"updateTime": "2026-05-27T20:57:01.912356099Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517",
"ref": "refs/branch-heads/7827"
}
}
}
[20:57:02.399] Task URL: https://cr-buildbucket.appspot.com/build/8680617122511435137
[20:57:02.399] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:2:0) after 5m20s
[20:57:03.347] Received PubSub notification, asking Buildbucket for the build status
[20:57:03.659] Build status: SCHEDULED
[20:58:01.089] Received PubSub notification, asking Buildbucket for the build status
[20:58:01.104] Build status: STARTED
[21:02:22.514] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:2:0)
[21:02:22.560] Build status: STARTED
[21:02:22.560] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:5:0) after 9m20s
[21:11:42.749] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:5:0)
[21:11:42.776] Build status: STARTED
[21:11:42.776] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:6:0) after 4m20s
[21:16:02.790] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:6:0)
[21:16:02.852] Build status: STARTED
[21:16:02.852] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:7:0) after 5m33s
[21:21:35.986] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:7:0)
[21:21:36.002] Build status: STARTED
[21:21:36.002] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:8:0) after 8m58s
[21:30:34.019] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:8:0)
[21:30:34.038] Build status: STARTED
[21:30:34.038] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:9:0) after 4m39s
[21:35:13.142] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:9:0)
[21:35:13.179] Build status: STARTED
[21:35:13.180] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:10:0) after 5m4s
[21:40:17.206] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:10:0)
[21:40:17.228] Build status: STARTED
[21:40:17.229] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:11:0) after 3m36s
[21:43:53.249] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:11:0)
[21:43:53.268] Build status: STARTED
[21:43:53.268] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:12:0) after 3m55s
[21:47:48.284] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:12:0)
[21:47:48.301] Build status: STARTED
[21:47:48.301] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:13:0) after 6m9s
[21:53:57.322] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:13:0)
[21:53:57.342] Build status: STARTED
[21:53:57.342] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:14:0) after 2m10s
[21:56:07.389] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:14:0)
[21:56:07.408] Build status: STARTED
[21:56:07.408] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:15:0) after 2m29s
[21:58:36.428] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:15:0)
[21:58:36.489] Build status: STARTED
[21:58:36.489] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:16:0) after 8m27s
[22:07:03.552] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:16:0)
[22:07:03.576] Build status: STARTED
[22:07:03.576] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:17:0) after 7m53s
[22:14:56.591] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:17:0)
[22:14:56.608] Build status: STARTED
[22:14:56.608] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:18:0) after 1m25s
[22:16:21.767] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:18:0)
[22:16:21.855] Build status: STARTED
[22:16:21.855] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:19:0) after 2m26s
[22:18:47.874] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:19:0)
[22:18:47.894] Build status: STARTED
[22:18:47.894] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:20:0) after 7m11s
[22:25:58.910] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:20:0)
[22:25:58.935] Build status: STARTED
[22:25:58.935] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:21:0) after 6m39s
[22:32:38.053] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:21:0)
[22:32:38.088] Build status: STARTED
[22:32:38.088] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:22:0) after 3m21s
[22:35:59.205] Handling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:22:0)
[22:35:59.223] Build status: STARTED
[22:35:59.223] Scheduling timer "check-buildbucket-build-status" (chromium-m149/linux-cast-x64-dbg:8846047184408060848:23:0) after 9m30s
[22:43:14.965] Received PubSub notification, asking Buildbucket for the build status
[22:43:14.983] Build:
{
"id": "8680617122511435137",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 316,
"createdBy": "project:chromium-m149",
"createTime": "2026-05-27T20:57:01.912356099Z",
"startTime": "2026-05-27T20:58:00.782770723Z",
"endTime": "2026-05-27T22:43:14.652499894Z",
"updateTime": "2026-05-27T22:43:14.652499894Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3f7bc9c86ef364cd1b2af6b2e33a6bedd1a4b517",
"ref": "refs/branch-heads/7827"
}
}
}
[22:43:14.983] Invocation finished in 1h46m14.263740323s with status SUCCEEDED