[15:48:58.864] New invocation is queued and will start shortly
[15:49:00.062] Starting the invocation (attempt 1)
[15:49:00.092] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9c253438fd00d42578536c9d8db0e0a042f98f78"
[15:49:00.092] Popped gitiles commit info from properties and tags
[15:49:00.092] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:49:00.092] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:49:00.093] Buildbucket request:
{
"requestId": "8849690442698827872",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-16-x64-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8849690442698827872",
"job": "chromium-m148/android-16-x64-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "954b6facbbe109ed50ccf5c5a65e24dd99696923"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@954b6facbbe109ed50ccf5c5a65e24dd99696923",
"title": "954b6facbbe109ed50ccf5c5a65e24dd99696923",
"url": "https://chromium.googlesource.com/chromium/src/+/954b6facbbe109ed50ccf5c5a65e24dd99696923"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b07302b6fc73988725591d09f85e20652452dc43"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b07302b6fc73988725591d09f85e20652452dc43",
"title": "b07302b6fc73988725591d09f85e20652452dc43",
"url": "https://chromium.googlesource.com/chromium/src/+/b07302b6fc73988725591d09f85e20652452dc43"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "df79699323bb464e0abba15aac29244b8c7b945b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@df79699323bb464e0abba15aac29244b8c7b945b",
"title": "df79699323bb464e0abba15aac29244b8c7b945b",
"url": "https://chromium.googlesource.com/chromium/src/+/df79699323bb464e0abba15aac29244b8c7b945b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8d16269303f5f04472066ad88ee6afab59aafae1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@8d16269303f5f04472066ad88ee6afab59aafae1",
"title": "8d16269303f5f04472066ad88ee6afab59aafae1",
"url": "https://chromium.googlesource.com/chromium/src/+/8d16269303f5f04472066ad88ee6afab59aafae1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b931c35c2617c59a5aa601678c828d38f4b99cc7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b931c35c2617c59a5aa601678c828d38f4b99cc7",
"title": "b931c35c2617c59a5aa601678c828d38f4b99cc7",
"url": "https://chromium.googlesource.com/chromium/src/+/b931c35c2617c59a5aa601678c828d38f4b99cc7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1b1f6ca82f0acd27dc17eeb1176958db7f6e6ba2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@1b1f6ca82f0acd27dc17eeb1176958db7f6e6ba2",
"title": "1b1f6ca82f0acd27dc17eeb1176958db7f6e6ba2",
"url": "https://chromium.googlesource.com/chromium/src/+/1b1f6ca82f0acd27dc17eeb1176958db7f6e6ba2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6c660c4f6a6a5b6f8d077c48390fdb1af0835503"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@6c660c4f6a6a5b6f8d077c48390fdb1af0835503",
"title": "6c660c4f6a6a5b6f8d077c48390fdb1af0835503",
"url": "https://chromium.googlesource.com/chromium/src/+/6c660c4f6a6a5b6f8d077c48390fdb1af0835503"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5434e1c908cf98d511a2d8ab00d55d8c15208488"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@5434e1c908cf98d511a2d8ab00d55d8c15208488",
"title": "5434e1c908cf98d511a2d8ab00d55d8c15208488",
"url": "https://chromium.googlesource.com/chromium/src/+/5434e1c908cf98d511a2d8ab00d55d8c15208488"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8fe8465ee0514887364da3ea957f323126891d5b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@8fe8465ee0514887364da3ea957f323126891d5b",
"title": "8fe8465ee0514887364da3ea957f323126891d5b",
"url": "https://chromium.googlesource.com/chromium/src/+/8fe8465ee0514887364da3ea957f323126891d5b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aee49292ad754fa1f910dec3879e831d41a42c5b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@aee49292ad754fa1f910dec3879e831d41a42c5b",
"title": "aee49292ad754fa1f910dec3879e831d41a42c5b",
"url": "https://chromium.googlesource.com/chromium/src/+/aee49292ad754fa1f910dec3879e831d41a42c5b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4ff7ab416e481dc2353e87d526faf63da47e2af0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4ff7ab416e481dc2353e87d526faf63da47e2af0",
"title": "4ff7ab416e481dc2353e87d526faf63da47e2af0",
"url": "https://chromium.googlesource.com/chromium/src/+/4ff7ab416e481dc2353e87d526faf63da47e2af0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b84a5a97b76264488d16a52cbbd999af49653196"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@b84a5a97b76264488d16a52cbbd999af49653196",
"title": "b84a5a97b76264488d16a52cbbd999af49653196",
"url": "https://chromium.googlesource.com/chromium/src/+/b84a5a97b76264488d16a52cbbd999af49653196"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4df1bb9e88034e1f0336ede9d421dc8f35d0fafd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@4df1bb9e88034e1f0336ede9d421dc8f35d0fafd",
"title": "4df1bb9e88034e1f0336ede9d421dc8f35d0fafd",
"url": "https://chromium.googlesource.com/chromium/src/+/4df1bb9e88034e1f0336ede9d421dc8f35d0fafd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "eef8cd2808a31feb1b1e52246034ddc0d2caacf9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@eef8cd2808a31feb1b1e52246034ddc0d2caacf9",
"title": "eef8cd2808a31feb1b1e52246034ddc0d2caacf9",
"url": "https://chromium.googlesource.com/chromium/src/+/eef8cd2808a31feb1b1e52246034ddc0d2caacf9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "09f71c8e62214be899e90e76d4a773d56d8c602b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@09f71c8e62214be899e90e76d4a773d56d8c602b",
"title": "09f71c8e62214be899e90e76d4a773d56d8c602b",
"url": "https://chromium.googlesource.com/chromium/src/+/09f71c8e62214be899e90e76d4a773d56d8c602b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "636492aa04f4c2317543f0209040f123974939f7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@636492aa04f4c2317543f0209040f123974939f7",
"title": "636492aa04f4c2317543f0209040f123974939f7",
"url": "https://chromium.googlesource.com/chromium/src/+/636492aa04f4c2317543f0209040f123974939f7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9c253438fd00d42578536c9d8db0e0a042f98f78"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@9c253438fd00d42578536c9d8db0e0a042f98f78",
"title": "9c253438fd00d42578536c9d8db0e0a042f98f78",
"url": "https://chromium.googlesource.com/chromium/src/+/9c253438fd00d42578536c9d8db0e0a042f98f78"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c253438fd00d42578536c9d8db0e0a042f98f78",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8849690442698827872"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/android-16-x64-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:49:00.629] Scheduled build:
{
"id": "8684260380695881889",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-16-x64-rel"
},
"number": 148,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-17T15:49:00.153991851Z",
"updateTime": "2026-04-17T15:49:00.153991851Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c253438fd00d42578536c9d8db0e0a042f98f78",
"ref": "refs/branch-heads/7778"
}
},
"canary": true
}
[15:49:00.629] Task URL: https://cr-buildbucket.appspot.com/build/8684260380695881889
[15:49:00.629] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:2:0) after 5m31s
[15:49:01.563] Received PubSub notification, asking Buildbucket for the build status
[15:49:01.583] Build status: SCHEDULED
[15:53:44.341] Received PubSub notification, asking Buildbucket for the build status
[15:53:44.411] Build status: STARTED
[15:54:31.645] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:2:0)
[15:54:31.666] Build status: STARTED
[15:54:31.666] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:5:0) after 6m1s
[16:00:32.699] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:5:0)
[16:00:32.728] Build status: STARTED
[16:00:32.728] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:6:0) after 7m10s
[16:07:42.761] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:6:0)
[16:07:42.776] Build status: STARTED
[16:07:42.776] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:7:0) after 1m36s
[16:09:18.847] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:7:0)
[16:09:18.919] Build status: STARTED
[16:09:18.919] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:8:0) after 7m13s
[16:16:32.016] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:8:0)
[16:16:32.049] Build status: STARTED
[16:16:32.050] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:9:0) after 8m51s
[16:25:23.071] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:9:0)
[16:25:23.091] Build status: STARTED
[16:25:23.091] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:10:0) after 4m47s
[16:30:10.196] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:10:0)
[16:30:10.243] Build status: STARTED
[16:30:10.243] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:11:0) after 2m55s
[16:33:05.323] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:11:0)
[16:33:05.344] Build status: STARTED
[16:33:05.344] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:12:0) after 5m18s
[16:38:23.445] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:12:0)
[16:38:23.467] Build status: STARTED
[16:38:23.467] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:13:0) after 4m55s
[16:43:18.492] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:13:0)
[16:43:18.513] Build status: STARTED
[16:43:18.513] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:14:0) after 9m52s
[16:53:10.551] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:14:0)
[16:53:10.569] Build status: STARTED
[16:53:10.569] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:15:0) after 1m16s
[16:54:26.587] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:15:0)
[16:54:26.607] Build status: STARTED
[16:54:26.608] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:16:0) after 6m18s
[17:00:44.722] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:16:0)
[17:00:44.801] Build status: STARTED
[17:00:44.801] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:17:0) after 4m7s
[17:04:51.818] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:17:0)
[17:04:51.837] Build status: STARTED
[17:04:51.837] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:18:0) after 9m32s
[17:14:23.849] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:18:0)
[17:14:23.878] Build status: STARTED
[17:14:23.878] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:19:0) after 4m42s
[17:19:05.918] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:19:0)
[17:19:05.934] Build status: STARTED
[17:19:05.934] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:20:0) after 2m41s
[17:21:46.953] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:20:0)
[17:21:47.005] Build status: STARTED
[17:21:47.005] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:21:0) after 2m29s
[17:24:16.059] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:21:0)
[17:24:16.082] Build status: STARTED
[17:24:16.082] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:22:0) after 8m53s
[17:33:09.150] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:22:0)
[17:33:09.182] Build status: STARTED
[17:33:09.182] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:23:0) after 9m42s
[17:42:51.252] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:23:0)
[17:42:51.278] Build status: STARTED
[17:42:51.278] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:24:0) after 3m48s
[17:46:39.367] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:24:0)
[17:46:39.390] Build status: STARTED
[17:46:39.390] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:25:0) after 4m32s
[17:51:11.406] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:25:0)
[17:51:11.560] Build status: STARTED
[17:51:11.560] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:26:0) after 5m26s
[17:56:37.620] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:26:0)
[17:56:37.685] Build status: STARTED
[17:56:37.685] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:27:0) after 5m2s
[18:01:39.697] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:27:0)
[18:01:39.715] Build status: STARTED
[18:01:39.715] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:28:0) after 7m16s
[18:08:55.750] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:28:0)
[18:08:55.804] Build status: STARTED
[18:08:55.804] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:29:0) after 3m53s
[18:12:48.829] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:29:0)
[18:12:48.848] Build status: STARTED
[18:12:48.848] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:30:0) after 9m38s
[18:22:27.004] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:30:0)
[18:22:27.034] Build status: STARTED
[18:22:27.034] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:31:0) after 4m35s
[18:27:02.056] Handling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:31:0)
[18:27:02.098] Build status: STARTED
[18:27:02.098] Scheduling timer "check-buildbucket-build-status" (chromium-m148/android-16-x64-rel:8849690442698827872:32:0) after 1m55s
[18:27:58.705] Received PubSub notification, asking Buildbucket for the build status
[18:27:58.726] Build:
{
"id": "8684260380695881889",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "android-16-x64-rel"
},
"number": 148,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-17T15:49:00.153991851Z",
"startTime": "2026-04-17T15:53:44.187166520Z",
"endTime": "2026-04-17T18:27:58.164086957Z",
"updateTime": "2026-04-17T18:27:58.164086957Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c253438fd00d42578536c9d8db0e0a042f98f78",
"ref": "refs/branch-heads/7778"
}
},
"canary": true
}
[18:27:58.726] Invocation finished in 2h38m59.86633487s with status SUCCEEDED