[09:05:23.046] New invocation is queued and will start shortly
[09:05:24.225] Starting the invocation (attempt 1)
[09:05:24.249] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2db31e10780ca47f87935592c83859703b0c99f1"
[09:05:24.249] Popped gitiles commit info from properties and tags
[09:05:24.249] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:05:24.249] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:05:24.249] Buildbucket request:
{
"requestId": "8847088522804020896",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8847088522804020896",
"job": "chromium-m149/fuchsia-x64-cast-receiver-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "453f1378978ad43cdaaeeefda513a0d88ae6d58c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@453f1378978ad43cdaaeeefda513a0d88ae6d58c",
"title": "453f1378978ad43cdaaeeefda513a0d88ae6d58c",
"url": "https://chromium.googlesource.com/chromium/src/+/453f1378978ad43cdaaeeefda513a0d88ae6d58c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5bd9e3360286f531ca428e091c9d80b6edab253f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@5bd9e3360286f531ca428e091c9d80b6edab253f",
"title": "5bd9e3360286f531ca428e091c9d80b6edab253f",
"url": "https://chromium.googlesource.com/chromium/src/+/5bd9e3360286f531ca428e091c9d80b6edab253f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d8284f7c32d2de8ca20258db57a1e9e4f174ecf1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@d8284f7c32d2de8ca20258db57a1e9e4f174ecf1",
"title": "d8284f7c32d2de8ca20258db57a1e9e4f174ecf1",
"url": "https://chromium.googlesource.com/chromium/src/+/d8284f7c32d2de8ca20258db57a1e9e4f174ecf1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "024a871a813fbe260b5b76315288b9437b54bb73"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@024a871a813fbe260b5b76315288b9437b54bb73",
"title": "024a871a813fbe260b5b76315288b9437b54bb73",
"url": "https://chromium.googlesource.com/chromium/src/+/024a871a813fbe260b5b76315288b9437b54bb73"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9c246f11137cde374c3dbc28c208447914aee07f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@9c246f11137cde374c3dbc28c208447914aee07f",
"title": "9c246f11137cde374c3dbc28c208447914aee07f",
"url": "https://chromium.googlesource.com/chromium/src/+/9c246f11137cde374c3dbc28c208447914aee07f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7827",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2db31e10780ca47f87935592c83859703b0c99f1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7827@2db31e10780ca47f87935592c83859703b0c99f1",
"title": "2db31e10780ca47f87935592c83859703b0c99f1",
"url": "https://chromium.googlesource.com/chromium/src/+/2db31e10780ca47f87935592c83859703b0c99f1"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2db31e10780ca47f87935592c83859703b0c99f1",
"ref": "refs/branch-heads/7827"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8847088522804020896"
},
{
"key": "scheduler_job_id",
"value": "chromium-m149/fuchsia-x64-cast-receiver-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:05:24.982] Scheduled build:
{
"id": "8681658460775447521",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 98,
"createdBy": "project:chromium-m149",
"createTime": "2026-05-16T09:05:24.355391580Z",
"updateTime": "2026-05-16T09:05:24.355391580Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2db31e10780ca47f87935592c83859703b0c99f1",
"ref": "refs/branch-heads/7827"
}
}
}
[09:05:24.982] Task URL: https://cr-buildbucket.appspot.com/build/8681658460775447521
[09:05:24.982] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:2:0) after 5m44s
[09:05:25.924] Received PubSub notification, asking Buildbucket for the build status
[09:05:25.949] Build status: SCHEDULED
[09:08:56.547] Received PubSub notification, asking Buildbucket for the build status
[09:08:56.565] Build status: STARTED
[09:11:08.993] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:2:0)
[09:11:09.087] Build status: STARTED
[09:11:09.087] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:5:0) after 8m2s
[09:19:11.330] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:5:0)
[09:19:11.375] Build status: STARTED
[09:19:11.375] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:6:0) after 2m46s
[09:21:57.387] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:6:0)
[09:21:57.404] Build status: STARTED
[09:21:57.404] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:7:0) after 7m50s
[09:29:47.419] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:7:0)
[09:29:47.452] Build status: STARTED
[09:29:47.452] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:8:0) after 3m36s
[09:33:23.466] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:8:0)
[09:33:23.486] Build status: STARTED
[09:33:23.486] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:9:0) after 7m43s
[09:41:06.599] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:9:0)
[09:41:06.618] Build status: STARTED
[09:41:06.618] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:10:0) after 9m40s
[09:50:46.731] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:10:0)
[09:50:46.808] Build status: STARTED
[09:50:46.808] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:11:0) after 1m8s
[09:51:54.824] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:11:0)
[09:51:54.839] Build status: STARTED
[09:51:54.839] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:12:0) after 2m17s
[09:54:11.952] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:12:0)
[09:54:11.970] Build status: STARTED
[09:54:11.970] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:13:0) after 2m48s
[09:57:00.035] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:13:0)
[09:57:00.114] Build status: STARTED
[09:57:00.114] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:14:0) after 7m23s
[10:04:23.214] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:14:0)
[10:04:23.235] Build status: STARTED
[10:04:23.236] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:15:0) after 7m46s
[10:12:09.249] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:15:0)
[10:12:09.264] Build status: STARTED
[10:12:09.264] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:16:0) after 4m56s
[10:17:05.279] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:16:0)
[10:17:05.296] Build status: STARTED
[10:17:05.296] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:17:0) after 5m36s
[10:22:41.310] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:17:0)
[10:22:41.382] Build status: STARTED
[10:22:41.382] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:18:0) after 2m1s
[10:24:42.496] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:18:0)
[10:24:42.525] Build status: STARTED
[10:24:42.525] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:19:0) after 7m17s
[10:31:59.644] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:19:0)
[10:31:59.669] Build status: STARTED
[10:31:59.669] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:20:0) after 1m39s
[10:33:38.724] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:20:0)
[10:33:38.749] Build status: STARTED
[10:33:38.749] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:21:0) after 6m10s
[10:39:48.830] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:21:0)
[10:39:48.847] Build status: STARTED
[10:39:48.847] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:22:0) after 8m19s
[10:48:07.920] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:22:0)
[10:48:07.938] Build status: STARTED
[10:48:07.938] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:23:0) after 2m0s
[10:50:08.383] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:23:0)
[10:50:08.413] Build status: STARTED
[10:50:08.413] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:24:0) after 2m46s
[10:52:54.455] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:24:0)
[10:52:54.478] Build status: STARTED
[10:52:54.478] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:25:0) after 7m42s
[11:00:36.636] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:25:0)
[11:00:36.659] Build status: STARTED
[11:00:36.659] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:26:0) after 8m20s
[11:08:56.957] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:26:0)
[11:08:56.980] Build status: STARTED
[11:08:56.980] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:27:0) after 9m37s
[11:18:34.278] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:27:0)
[11:18:34.297] Build status: STARTED
[11:18:34.297] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:28:0) after 2m42s
[11:21:16.312] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:28:0)
[11:21:16.330] Build status: STARTED
[11:21:16.330] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:29:0) after 5m37s
[11:26:53.565] Handling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:29:0)
[11:26:53.581] Build status: STARTED
[11:26:53.581] Scheduling timer "check-buildbucket-build-status" (chromium-m149/fuchsia-x64-cast-receiver-dbg:8847088522804020896:30:0) after 6m11s
[11:28:21.733] Received PubSub notification, asking Buildbucket for the build status
[11:28:21.760] Build:
{
"id": "8681658460775447521",
"builder": {
"project": "chromium-m149",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 98,
"createdBy": "project:chromium-m149",
"createTime": "2026-05-16T09:05:24.355391580Z",
"startTime": "2026-05-16T09:08:56.245782527Z",
"endTime": "2026-05-16T11:28:21.276039444Z",
"updateTime": "2026-05-16T11:28:21.276039444Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2db31e10780ca47f87935592c83859703b0c99f1",
"ref": "refs/branch-heads/7827"
}
}
}
[11:28:21.760] Invocation finished in 2h22m58.722384134s with status SUCCEEDED