[15:43:46.789] New invocation is queued and will start shortly
[15:43:47.949] Starting the invocation (attempt 1)
[15:43:47.981] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cbddb4e27a4862dc82f731519cc8b5be00417d4b"
[15:43:47.981] Popped gitiles commit info from properties and tags
[15:43:47.981] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:43:47.981] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:43:47.982] Buildbucket request:
{
"requestId": "8851230918365813056",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "fuchsia-arm64-cast-receiver-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851230918365813056",
"job": "chromium-m147/fuchsia-arm64-cast-receiver-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "077a55fb71f1f490d8df841c4855f139906062da"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@077a55fb71f1f490d8df841c4855f139906062da",
"title": "077a55fb71f1f490d8df841c4855f139906062da",
"url": "https://chromium.googlesource.com/chromium/src/+/077a55fb71f1f490d8df841c4855f139906062da"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "decb3ef36a51f88c820dd0f8d55a6b81a2e8d0c3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@decb3ef36a51f88c820dd0f8d55a6b81a2e8d0c3",
"title": "decb3ef36a51f88c820dd0f8d55a6b81a2e8d0c3",
"url": "https://chromium.googlesource.com/chromium/src/+/decb3ef36a51f88c820dd0f8d55a6b81a2e8d0c3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4b60a5c9ae22486d63140bcc0471ee56b5a97f21"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@4b60a5c9ae22486d63140bcc0471ee56b5a97f21",
"title": "4b60a5c9ae22486d63140bcc0471ee56b5a97f21",
"url": "https://chromium.googlesource.com/chromium/src/+/4b60a5c9ae22486d63140bcc0471ee56b5a97f21"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9111c95423c0272dcca9c67552e40a507758a8a3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@9111c95423c0272dcca9c67552e40a507758a8a3",
"title": "9111c95423c0272dcca9c67552e40a507758a8a3",
"url": "https://chromium.googlesource.com/chromium/src/+/9111c95423c0272dcca9c67552e40a507758a8a3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a106dc2f48ff7b276dc591fce5c94d2b114b2f44"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@a106dc2f48ff7b276dc591fce5c94d2b114b2f44",
"title": "a106dc2f48ff7b276dc591fce5c94d2b114b2f44",
"url": "https://chromium.googlesource.com/chromium/src/+/a106dc2f48ff7b276dc591fce5c94d2b114b2f44"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a4a2c640a6aa41fa800ad47d08b09a4a467bae16"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@a4a2c640a6aa41fa800ad47d08b09a4a467bae16",
"title": "a4a2c640a6aa41fa800ad47d08b09a4a467bae16",
"url": "https://chromium.googlesource.com/chromium/src/+/a4a2c640a6aa41fa800ad47d08b09a4a467bae16"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8ea6f3f5a4ddc29a53344f5ddf57217e615d076d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@8ea6f3f5a4ddc29a53344f5ddf57217e615d076d",
"title": "8ea6f3f5a4ddc29a53344f5ddf57217e615d076d",
"url": "https://chromium.googlesource.com/chromium/src/+/8ea6f3f5a4ddc29a53344f5ddf57217e615d076d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "47ff90da7d611be8a93c817fce18a621bb0f07b2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@47ff90da7d611be8a93c817fce18a621bb0f07b2",
"title": "47ff90da7d611be8a93c817fce18a621bb0f07b2",
"url": "https://chromium.googlesource.com/chromium/src/+/47ff90da7d611be8a93c817fce18a621bb0f07b2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3b8ae5f1316c0ed45754acaac14bf96c80f49afc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@3b8ae5f1316c0ed45754acaac14bf96c80f49afc",
"title": "3b8ae5f1316c0ed45754acaac14bf96c80f49afc",
"url": "https://chromium.googlesource.com/chromium/src/+/3b8ae5f1316c0ed45754acaac14bf96c80f49afc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f1b563781ff37b227534e919d409499a0c80592b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@f1b563781ff37b227534e919d409499a0c80592b",
"title": "f1b563781ff37b227534e919d409499a0c80592b",
"url": "https://chromium.googlesource.com/chromium/src/+/f1b563781ff37b227534e919d409499a0c80592b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7727",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cbddb4e27a4862dc82f731519cc8b5be00417d4b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7727@cbddb4e27a4862dc82f731519cc8b5be00417d4b",
"title": "cbddb4e27a4862dc82f731519cc8b5be00417d4b",
"url": "https://chromium.googlesource.com/chromium/src/+/cbddb4e27a4862dc82f731519cc8b5be00417d4b"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cbddb4e27a4862dc82f731519cc8b5be00417d4b",
"ref": "refs/branch-heads/7727"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851230918365813056"
},
{
"key": "scheduler_job_id",
"value": "chromium-m147/fuchsia-arm64-cast-receiver-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:43:48.504] Scheduled build:
{
"id": "8685800856383416337",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "fuchsia-arm64-cast-receiver-rel"
},
"number": 298,
"createdBy": "project:chromium-m147",
"createTime": "2026-03-31T15:43:48.055961227Z",
"updateTime": "2026-03-31T15:43:48.055961227Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cbddb4e27a4862dc82f731519cc8b5be00417d4b",
"ref": "refs/branch-heads/7727"
}
}
}
[15:43:48.504] Task URL: https://cr-buildbucket.appspot.com/build/8685800856383416337
[15:43:48.504] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:2:0) after 3m46s
[15:43:52.034] Received PubSub notification, asking Buildbucket for the build status
[15:43:52.054] Build status: SCHEDULED
[15:44:07.961] Received PubSub notification, asking Buildbucket for the build status
[15:44:07.976] Build status: STARTED
[15:47:34.613] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:2:0)
[15:47:34.639] Build status: STARTED
[15:47:34.639] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:5:0) after 3m57s
[15:51:31.714] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:5:0)
[15:51:31.733] Build status: STARTED
[15:51:31.733] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:6:0) after 2m29s
[15:54:00.789] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:6:0)
[15:54:00.810] Build status: STARTED
[15:54:00.810] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:7:0) after 3m41s
[15:57:41.832] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:7:0)
[15:57:41.858] Build status: STARTED
[15:57:41.858] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:8:0) after 9m47s
[16:07:28.878] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:8:0)
[16:07:28.926] Build status: STARTED
[16:07:28.927] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:9:0) after 2m22s
[16:09:51.032] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:9:0)
[16:09:51.052] Build status: STARTED
[16:09:51.052] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:10:0) after 7m50s
[16:17:41.082] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:10:0)
[16:17:41.100] Build status: STARTED
[16:17:41.101] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:11:0) after 5m57s
[16:23:38.199] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:11:0)
[16:23:38.223] Build status: STARTED
[16:23:38.223] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:12:0) after 6m23s
[16:30:01.229] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:12:0)
[16:30:01.302] Build status: STARTED
[16:30:01.302] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:13:0) after 8m15s
[16:38:16.359] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:13:0)
[16:38:16.380] Build status: STARTED
[16:38:16.380] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:14:0) after 6m54s
[16:45:10.457] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:14:0)
[16:45:10.481] Build status: STARTED
[16:45:10.481] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:15:0) after 5m49s
[16:50:59.594] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:15:0)
[16:50:59.663] Build status: STARTED
[16:50:59.663] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:16:0) after 1m41s
[16:52:40.632] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:16:0)
[16:52:40.654] Build status: STARTED
[16:52:40.654] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:17:0) after 8m34s
[17:01:14.666] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:17:0)
[17:01:14.692] Build status: STARTED
[17:01:14.692] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:18:0) after 4m59s
[17:06:13.714] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:18:0)
[17:06:13.740] Build status: STARTED
[17:06:13.740] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:19:0) after 7m44s
[17:13:57.831] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:19:0)
[17:13:57.851] Build status: STARTED
[17:13:57.851] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:20:0) after 6m9s
[17:20:06.996] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:20:0)
[17:20:07.025] Build status: STARTED
[17:20:07.025] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:21:0) after 8m33s
[17:28:40.043] Handling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:21:0)
[17:28:40.060] Build status: STARTED
[17:28:40.060] Scheduling timer "check-buildbucket-build-status" (chromium-m147/fuchsia-arm64-cast-receiver-rel:8851230918365813056:22:0) after 9m57s
[17:37:49.962] Received PubSub notification, asking Buildbucket for the build status
[17:37:50.132] Build:
{
"id": "8685800856383416337",
"builder": {
"project": "chromium-m147",
"bucket": "ci",
"builder": "fuchsia-arm64-cast-receiver-rel"
},
"number": 298,
"createdBy": "project:chromium-m147",
"createTime": "2026-03-31T15:43:48.055961227Z",
"startTime": "2026-03-31T15:44:00.349716560Z",
"endTime": "2026-03-31T17:37:49.510903886Z",
"updateTime": "2026-03-31T17:37:49.510903886Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cbddb4e27a4862dc82f731519cc8b5be00417d4b",
"ref": "refs/branch-heads/7727"
}
}
}
[17:37:50.132] Invocation finished in 1h54m3.351743312s with status SUCCEEDED