[18:25:15.399] New invocation is queued and will start shortly
[18:25:16.664] Starting the invocation (attempt 1)
[18:25:16.706] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d61fe750b40df3d9313b57412530e1d50c48e3c7"
[18:25:16.706] Popped gitiles commit info from properties and tags
[18:25:16.706] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:25:16.706] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:25:16.706] Buildbucket request:
{
"requestId": "8845150762370673936",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8845150762370673936",
"job": "chromium-m150/linux-cast-x64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8eb1b1c4e8a69d9b32a1d3bdad80318bd17ce7cd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@8eb1b1c4e8a69d9b32a1d3bdad80318bd17ce7cd",
"title": "8eb1b1c4e8a69d9b32a1d3bdad80318bd17ce7cd",
"url": "https://chromium.googlesource.com/chromium/src/+/8eb1b1c4e8a69d9b32a1d3bdad80318bd17ce7cd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "37ea7a356c991033afa55ca0f6ffaa5daf92b403"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@37ea7a356c991033afa55ca0f6ffaa5daf92b403",
"title": "37ea7a356c991033afa55ca0f6ffaa5daf92b403",
"url": "https://chromium.googlesource.com/chromium/src/+/37ea7a356c991033afa55ca0f6ffaa5daf92b403"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b785a8c92f97b5fb38e8cfc1bdef35e548f17a47"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@b785a8c92f97b5fb38e8cfc1bdef35e548f17a47",
"title": "b785a8c92f97b5fb38e8cfc1bdef35e548f17a47",
"url": "https://chromium.googlesource.com/chromium/src/+/b785a8c92f97b5fb38e8cfc1bdef35e548f17a47"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f32b4ee773f2f01c30cec43df116d2622078a33b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@f32b4ee773f2f01c30cec43df116d2622078a33b",
"title": "f32b4ee773f2f01c30cec43df116d2622078a33b",
"url": "https://chromium.googlesource.com/chromium/src/+/f32b4ee773f2f01c30cec43df116d2622078a33b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f6eddafb7f2d36d6a30ee279c14e20b1493966f1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@f6eddafb7f2d36d6a30ee279c14e20b1493966f1",
"title": "f6eddafb7f2d36d6a30ee279c14e20b1493966f1",
"url": "https://chromium.googlesource.com/chromium/src/+/f6eddafb7f2d36d6a30ee279c14e20b1493966f1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "70fa5e705f31e0c76529f2eca2534f375a7571c8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@70fa5e705f31e0c76529f2eca2534f375a7571c8",
"title": "70fa5e705f31e0c76529f2eca2534f375a7571c8",
"url": "https://chromium.googlesource.com/chromium/src/+/70fa5e705f31e0c76529f2eca2534f375a7571c8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "95279e343e16bcc8036c7706f7407bc64d6fc5b5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@95279e343e16bcc8036c7706f7407bc64d6fc5b5",
"title": "95279e343e16bcc8036c7706f7407bc64d6fc5b5",
"url": "https://chromium.googlesource.com/chromium/src/+/95279e343e16bcc8036c7706f7407bc64d6fc5b5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "406ffd5fab118dfceb22b7283a161c667ff973f6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@406ffd5fab118dfceb22b7283a161c667ff973f6",
"title": "406ffd5fab118dfceb22b7283a161c667ff973f6",
"url": "https://chromium.googlesource.com/chromium/src/+/406ffd5fab118dfceb22b7283a161c667ff973f6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1e14c7ca46ba41651c6f708bd3b6fd06201fdb38"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@1e14c7ca46ba41651c6f708bd3b6fd06201fdb38",
"title": "1e14c7ca46ba41651c6f708bd3b6fd06201fdb38",
"url": "https://chromium.googlesource.com/chromium/src/+/1e14c7ca46ba41651c6f708bd3b6fd06201fdb38"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f0c7c68e482353546f876aea9eb2424ece485dd0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@f0c7c68e482353546f876aea9eb2424ece485dd0",
"title": "f0c7c68e482353546f876aea9eb2424ece485dd0",
"url": "https://chromium.googlesource.com/chromium/src/+/f0c7c68e482353546f876aea9eb2424ece485dd0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8028cb2bb9d05e5b943b7ed8f6321884e054d64a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@8028cb2bb9d05e5b943b7ed8f6321884e054d64a",
"title": "8028cb2bb9d05e5b943b7ed8f6321884e054d64a",
"url": "https://chromium.googlesource.com/chromium/src/+/8028cb2bb9d05e5b943b7ed8f6321884e054d64a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d634ee2c0c92e4c7f1e878e2ed9e66663412d10a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@d634ee2c0c92e4c7f1e878e2ed9e66663412d10a",
"title": "d634ee2c0c92e4c7f1e878e2ed9e66663412d10a",
"url": "https://chromium.googlesource.com/chromium/src/+/d634ee2c0c92e4c7f1e878e2ed9e66663412d10a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7871",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d61fe750b40df3d9313b57412530e1d50c48e3c7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7871@d61fe750b40df3d9313b57412530e1d50c48e3c7",
"title": "d61fe750b40df3d9313b57412530e1d50c48e3c7",
"url": "https://chromium.googlesource.com/chromium/src/+/d61fe750b40df3d9313b57412530e1d50c48e3c7"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d61fe750b40df3d9313b57412530e1d50c48e3c7",
"ref": "refs/branch-heads/7871"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8845150762370673936"
},
{
"key": "scheduler_job_id",
"value": "chromium-m150/linux-cast-x64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:25:17.249] Scheduled build:
{
"id": "8679720700281065537",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 64,
"createdBy": "project:chromium-m150",
"createTime": "2026-06-06T18:25:16.770147764Z",
"updateTime": "2026-06-06T18:25:16.770147764Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d61fe750b40df3d9313b57412530e1d50c48e3c7",
"ref": "refs/branch-heads/7871"
}
},
"canary": true
}
[18:25:17.249] Task URL: https://cr-buildbucket.appspot.com/build/8679720700281065537
[18:25:17.250] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:2:0) after 6m13s
[18:25:18.284] Received PubSub notification, asking Buildbucket for the build status
[18:25:18.328] Build status: SCHEDULED
[18:25:22.808] Received PubSub notification, asking Buildbucket for the build status
[18:25:22.825] Build status: STARTED
[18:31:30.369] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:2:0)
[18:31:30.388] Build status: STARTED
[18:31:30.388] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:5:0) after 6m29s
[18:37:59.548] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:5:0)
[18:37:59.582] Build status: STARTED
[18:37:59.582] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:6:0) after 6m36s
[18:44:35.598] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:6:0)
[18:44:35.617] Build status: STARTED
[18:44:35.617] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:7:0) after 6m1s
[18:50:36.637] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:7:0)
[18:50:36.654] Build status: STARTED
[18:50:36.654] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:8:0) after 9m56s
[19:00:32.719] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:8:0)
[19:00:32.765] Build status: STARTED
[19:00:32.766] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:9:0) after 3m29s
[19:04:01.932] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:9:0)
[19:04:01.959] Build status: STARTED
[19:04:01.959] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:10:0) after 5m45s
[19:09:46.977] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:10:0)
[19:09:46.997] Build status: STARTED
[19:09:46.997] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:11:0) after 6m18s
[19:16:05.155] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:11:0)
[19:16:05.177] Build status: STARTED
[19:16:05.177] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:12:0) after 7m47s
[19:23:52.429] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:12:0)
[19:23:52.452] Build status: STARTED
[19:23:52.452] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:13:0) after 6m47s
[19:30:39.607] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:13:0)
[19:30:39.626] Build status: STARTED
[19:30:39.626] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:14:0) after 7m52s
[19:38:31.746] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:14:0)
[19:38:31.763] Build status: STARTED
[19:38:31.763] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:15:0) after 6m53s
[19:45:24.910] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:15:0)
[19:45:24.977] Build status: STARTED
[19:45:24.977] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:16:0) after 1m35s
[19:47:00.036] Handling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:16:0)
[19:47:00.062] Build status: STARTED
[19:47:00.062] Scheduling timer "check-buildbucket-build-status" (chromium-m150/linux-cast-x64-dbg:8845150762370673936:17:0) after 8m4s
[19:51:49.795] Received PubSub notification, asking Buildbucket for the build status
[19:51:49.819] Build:
{
"id": "8679720700281065537",
"builder": {
"project": "chromium-m150",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 64,
"createdBy": "project:chromium-m150",
"createTime": "2026-06-06T18:25:16.770147764Z",
"startTime": "2026-06-06T18:25:22.437113376Z",
"endTime": "2026-06-06T19:51:49.401561619Z",
"updateTime": "2026-06-06T19:51:49.401561619Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d61fe750b40df3d9313b57412530e1d50c48e3c7",
"ref": "refs/branch-heads/7871"
}
},
"canary": true
}
[19:51:49.819] Invocation finished in 1h26m34.426114054s with status SUCCEEDED