[18:50:18.373] New invocation is queued and will start shortly
[18:50:19.487] Starting the invocation (attempt 1)
[18:50:19.515] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b7ee94ff391a968d8a8d0f493a108a9a50b907f5"
[18:50:19.515] Popped gitiles commit info from properties and tags
[18:50:19.515] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:50:19.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:50:19.516] Buildbucket request:
{
"requestId": "8844786798521849776",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "fuchsia-arm64-cast-receiver-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8844786798521849776",
"job": "chromium-m150/fuchsia-arm64-cast-receiver-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "262e6a51b381c972a5c2daf3d1cbb341e7e710e4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@262e6a51b381c972a5c2daf3d1cbb341e7e710e4",
"title": "262e6a51b381c972a5c2daf3d1cbb341e7e710e4",
"url": "https://chromium.googlesource.com/chromium/src/+/262e6a51b381c972a5c2daf3d1cbb341e7e710e4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "151931eee5cedb7f523c863394e82f8afbd9707d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@151931eee5cedb7f523c863394e82f8afbd9707d",
"title": "151931eee5cedb7f523c863394e82f8afbd9707d",
"url": "https://chromium.googlesource.com/chromium/src/+/151931eee5cedb7f523c863394e82f8afbd9707d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "681bb92074bc38b1ba4c09e8d7107c49a4534a19"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@681bb92074bc38b1ba4c09e8d7107c49a4534a19",
"title": "681bb92074bc38b1ba4c09e8d7107c49a4534a19",
"url": "https://chromium.googlesource.com/chromium/src/+/681bb92074bc38b1ba4c09e8d7107c49a4534a19"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f5ad2609a11caa96dda7ea788ea42d80af93f77e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@f5ad2609a11caa96dda7ea788ea42d80af93f77e",
"title": "f5ad2609a11caa96dda7ea788ea42d80af93f77e",
"url": "https://chromium.googlesource.com/chromium/src/+/f5ad2609a11caa96dda7ea788ea42d80af93f77e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "71252dd2725643134eaeb3ec420cf8971fdf010d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@71252dd2725643134eaeb3ec420cf8971fdf010d",
"title": "71252dd2725643134eaeb3ec420cf8971fdf010d",
"url": "https://chromium.googlesource.com/chromium/src/+/71252dd2725643134eaeb3ec420cf8971fdf010d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "935287d492a64b431ab1e39572ffcc8bc2ab41b4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@935287d492a64b431ab1e39572ffcc8bc2ab41b4",
"title": "935287d492a64b431ab1e39572ffcc8bc2ab41b4",
"url": "https://chromium.googlesource.com/chromium/src/+/935287d492a64b431ab1e39572ffcc8bc2ab41b4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d91c63417cef17335554fdba18aa06686517c5d6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@d91c63417cef17335554fdba18aa06686517c5d6",
"title": "d91c63417cef17335554fdba18aa06686517c5d6",
"url": "https://chromium.googlesource.com/chromium/src/+/d91c63417cef17335554fdba18aa06686517c5d6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "71d1b78c63dc7213c3c57bb4324d22b4421a134e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@71d1b78c63dc7213c3c57bb4324d22b4421a134e",
"title": "71d1b78c63dc7213c3c57bb4324d22b4421a134e",
"url": "https://chromium.googlesource.com/chromium/src/+/71d1b78c63dc7213c3c57bb4324d22b4421a134e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d41eb658091ac2b11ed82fecc4733ca73e6c1fb0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@d41eb658091ac2b11ed82fecc4733ca73e6c1fb0",
"title": "d41eb658091ac2b11ed82fecc4733ca73e6c1fb0",
"url": "https://chromium.googlesource.com/chromium/src/+/d41eb658091ac2b11ed82fecc4733ca73e6c1fb0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "293bf51003c81a94b258471c4ae75e42b5ec612c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@293bf51003c81a94b258471c4ae75e42b5ec612c",
"title": "293bf51003c81a94b258471c4ae75e42b5ec612c",
"url": "https://chromium.googlesource.com/chromium/src/+/293bf51003c81a94b258471c4ae75e42b5ec612c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fc8c54381abaa48c7190c5a6ec87bd63ca68eb28"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@fc8c54381abaa48c7190c5a6ec87bd63ca68eb28",
"title": "fc8c54381abaa48c7190c5a6ec87bd63ca68eb28",
"url": "https://chromium.googlesource.com/chromium/src/+/fc8c54381abaa48c7190c5a6ec87bd63ca68eb28"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b7ee94ff391a968d8a8d0f493a108a9a50b907f5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@b7ee94ff391a968d8a8d0f493a108a9a50b907f5",
"title": "b7ee94ff391a968d8a8d0f493a108a9a50b907f5",
"url": "https://chromium.googlesource.com/chromium/src/+/b7ee94ff391a968d8a8d0f493a108a9a50b907f5"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b7ee94ff391a968d8a8d0f493a108a9a50b907f5",
"ref": "refs/branch-heads/7871"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8844786798521849776"
},
{
"key": "scheduler_job_id",
"value": "chromium-m150/fuchsia-arm64-cast-receiver-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:50:20.132] Scheduled build:
{
"id": "8679356736597269249",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "fuchsia-arm64-cast-receiver-rel"
},
"number": 96,
"createdBy": "project:chromium-m150",
"createTime": "2026-06-10T18:50:19.587904675Z",
"updateTime": "2026-06-10T18:50:19.587904675Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b7ee94ff391a968d8a8d0f493a108a9a50b907f5",
"ref": "refs/branch-heads/7871"
}
}
}
[18:50:20.132] Task URL: https://cr-buildbucket.appspot.com/build/8679356736597269249
[18:50:20.132] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:2:0) after 4m27s
[18:50:21.021] Received PubSub notification, asking Buildbucket for the build status
[18:50:21.083] Build status: SCHEDULED
[18:50:28.709] Received PubSub notification, asking Buildbucket for the build status
[18:50:28.729] Build status: STARTED
[18:54:47.147] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:2:0)
[18:54:47.205] Build status: STARTED
[18:54:47.205] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:5:0) after 8m5s
[19:02:52.227] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:5:0)
[19:02:52.244] Build status: STARTED
[19:02:52.244] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:6:0) after 7m37s
[19:10:29.282] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:6:0)
[19:10:29.302] Build status: STARTED
[19:10:29.302] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:7:0) after 5m33s
[19:16:02.317] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:7:0)
[19:16:02.332] Build status: STARTED
[19:16:02.332] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:8:0) after 8m15s
[19:24:17.344] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:8:0)
[19:24:17.360] Build status: STARTED
[19:24:17.360] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:9:0) after 1m28s
[19:25:45.526] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:9:0)
[19:25:45.551] Build status: STARTED
[19:25:45.551] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:10:0) after 8m40s
[19:34:25.567] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:10:0)
[19:34:25.587] Build status: STARTED
[19:34:25.587] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:11:0) after 2m13s
[19:36:38.661] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:11:0)
[19:36:38.679] Build status: STARTED
[19:36:38.679] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:12:0) after 4m27s
[19:41:05.733] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:12:0)
[19:41:05.752] Build status: STARTED
[19:41:05.752] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:13:0) after 8m50s
[19:49:55.833] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:13:0)
[19:49:55.854] Build status: STARTED
[19:49:55.854] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:14:0) after 2m2s
[19:51:57.827] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:14:0)
[19:51:57.852] Build status: STARTED
[19:51:57.852] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:15:0) after 1m27s
[19:53:25.025] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:15:0)
[19:53:25.042] Build status: STARTED
[19:53:25.042] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:16:0) after 6m18s
[19:59:43.215] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:16:0)
[19:59:43.236] Build status: STARTED
[19:59:43.236] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:17:0) after 4m38s
[20:04:21.272] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:17:0)
[20:04:21.291] Build status: STARTED
[20:04:21.291] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:18:0) after 1m33s
[20:05:54.374] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:18:0)
[20:05:54.402] Build status: STARTED
[20:05:54.402] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:19:0) after 2m0s
[20:07:54.405] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:19:0)
[20:07:54.426] Build status: STARTED
[20:07:54.426] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:20:0) after 1m8s
[20:09:02.706] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:20:0)
[20:09:02.786] Build status: STARTED
[20:09:02.786] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:21:0) after 1m34s
[20:10:36.826] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:21:0)
[20:10:36.845] Build status: STARTED
[20:10:36.845] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:22:0) after 8m17s
[20:18:53.902] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:22:0)
[20:18:53.933] Build status: STARTED
[20:18:53.933] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:23:0) after 9m4s
[20:27:57.950] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:23:0)
[20:27:57.988] Build status: STARTED
[20:27:57.988] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:24:0) after 3m20s
[20:31:18.028] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:24:0)
[20:31:18.052] Build status: STARTED
[20:31:18.052] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:25:0) after 5m8s
[20:36:26.117] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:25:0)
[20:36:26.191] Build status: STARTED
[20:36:26.191] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:26:0) after 5m10s
[20:41:36.197] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:26:0)
[20:41:36.222] Build status: STARTED
[20:41:36.222] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:27:0) after 1m2s
[20:42:38.219] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:27:0)
[20:42:38.240] Build status: STARTED
[20:42:38.240] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:28:0) after 8m52s
[20:51:30.256] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:28:0)
[20:51:30.272] Build status: STARTED
[20:51:30.272] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:29:0) after 3m51s
[20:55:21.294] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:29:0)
[20:55:21.315] Build status: STARTED
[20:55:21.315] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:30:0) after 7m32s
[21:02:53.424] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:30:0)
[21:02:53.442] Build status: STARTED
[21:02:53.442] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:31:0) after 1m52s
[21:04:45.444] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:31:0)
[21:04:45.464] Build status: STARTED
[21:04:45.465] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:32:0) after 3m12s
[21:07:57.561] Handling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:32:0)
[21:07:57.602] Build status: STARTED
[21:07:57.602] Scheduling timer "check-buildbucket-build-status" (chromium-m150/fuchsia-arm64-cast-receiver-rel:8844786798521849776:33:0) after 6m23s
[21:12:22.013] Received PubSub notification, asking Buildbucket for the build status
[21:12:22.028] Build:
{
"id": "8679356736597269249",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "fuchsia-arm64-cast-receiver-rel"
},
"number": 96,
"createdBy": "project:chromium-m150",
"createTime": "2026-06-10T18:50:19.587904675Z",
"startTime": "2026-06-10T18:50:28.541707658Z",
"endTime": "2026-06-10T21:12:21.565053141Z",
"updateTime": "2026-06-10T21:12:21.565053141Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b7ee94ff391a968d8a8d0f493a108a9a50b907f5",
"ref": "refs/branch-heads/7871"
}
}
}
[21:12:22.028] Invocation finished in 2h22m3.660643598s with status SUCCEEDED