[22:46:20.455] New invocation is queued and will start shortly
[22:46:21.639] Starting the invocation (attempt 1)
[22:46:21.672] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e157b32f17200a16d0950f166564765c3cc028db"
[22:46:21.673] Popped gitiles commit info from properties and tags
[22:46:21.673] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:46:21.673] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:46:21.673] Buildbucket request:
{
"requestId": "8871407456629277056",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8871407456629277056",
"job": "chromium-m140/linux-cast-x64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "71c8fa92a451e31e6baf89dc51b1273d86751ab0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@71c8fa92a451e31e6baf89dc51b1273d86751ab0",
"title": "71c8fa92a451e31e6baf89dc51b1273d86751ab0",
"url": "https://chromium.googlesource.com/chromium/src/+/71c8fa92a451e31e6baf89dc51b1273d86751ab0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3233e5b38514b9f7817cdaa5c5d37350a53c0fed"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@3233e5b38514b9f7817cdaa5c5d37350a53c0fed",
"title": "3233e5b38514b9f7817cdaa5c5d37350a53c0fed",
"url": "https://chromium.googlesource.com/chromium/src/+/3233e5b38514b9f7817cdaa5c5d37350a53c0fed"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "164b4571452a3e5bea61238958d193ce48bc7caf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@164b4571452a3e5bea61238958d193ce48bc7caf",
"title": "164b4571452a3e5bea61238958d193ce48bc7caf",
"url": "https://chromium.googlesource.com/chromium/src/+/164b4571452a3e5bea61238958d193ce48bc7caf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "33cd68b905d41ca990f606dac79a4c8fa83a0e82"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@33cd68b905d41ca990f606dac79a4c8fa83a0e82",
"title": "33cd68b905d41ca990f606dac79a4c8fa83a0e82",
"url": "https://chromium.googlesource.com/chromium/src/+/33cd68b905d41ca990f606dac79a4c8fa83a0e82"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "97bea48cafdb4ea7387f3ca7e0a392fbdf3e58c9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@97bea48cafdb4ea7387f3ca7e0a392fbdf3e58c9",
"title": "97bea48cafdb4ea7387f3ca7e0a392fbdf3e58c9",
"url": "https://chromium.googlesource.com/chromium/src/+/97bea48cafdb4ea7387f3ca7e0a392fbdf3e58c9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "19d09ac5d3c6ddf58f19a3b916988438739318ce"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@19d09ac5d3c6ddf58f19a3b916988438739318ce",
"title": "19d09ac5d3c6ddf58f19a3b916988438739318ce",
"url": "https://chromium.googlesource.com/chromium/src/+/19d09ac5d3c6ddf58f19a3b916988438739318ce"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8fd165da2ae3f499d079b0cb3699731157741138"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@8fd165da2ae3f499d079b0cb3699731157741138",
"title": "8fd165da2ae3f499d079b0cb3699731157741138",
"url": "https://chromium.googlesource.com/chromium/src/+/8fd165da2ae3f499d079b0cb3699731157741138"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2b55e0a8d7985411617b938390d8660760825671"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@2b55e0a8d7985411617b938390d8660760825671",
"title": "2b55e0a8d7985411617b938390d8660760825671",
"url": "https://chromium.googlesource.com/chromium/src/+/2b55e0a8d7985411617b938390d8660760825671"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e157b32f17200a16d0950f166564765c3cc028db"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@e157b32f17200a16d0950f166564765c3cc028db",
"title": "e157b32f17200a16d0950f166564765c3cc028db",
"url": "https://chromium.googlesource.com/chromium/src/+/e157b32f17200a16d0950f166564765c3cc028db"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e157b32f17200a16d0950f166564765c3cc028db",
"ref": "refs/branch-heads/7339"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8871407456629277056"
},
{
"key": "scheduler_job_id",
"value": "chromium-m140/linux-cast-x64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:46:22.160] Scheduled build:
{
"id": "8705977394624284705",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 424,
"createdBy": "project:chromium-m140",
"createTime": "2025-08-20T22:46:21.741886045Z",
"updateTime": "2025-08-20T22:46:21.741886045Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e157b32f17200a16d0950f166564765c3cc028db",
"ref": "refs/branch-heads/7339"
}
}
}
[22:46:22.161] Task URL: https://cr-buildbucket.appspot.com/build/8705977394624284705
[22:46:22.161] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:2:0) after 8m52s
[22:46:28.066] Received PubSub notification, asking Buildbucket for the build status
[22:46:28.093] Build status: STARTED
[22:46:30.528] Received PubSub notification, asking Buildbucket for the build status
[22:46:30.617] Build status: STARTED
[22:55:14.174] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:2:0)
[22:55:14.197] Build status: STARTED
[22:55:14.198] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:5:0) after 7m28s
[23:02:42.261] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:5:0)
[23:02:42.281] Build status: STARTED
[23:02:42.281] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:6:0) after 7m33s
[23:10:15.302] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:6:0)
[23:10:15.324] Build status: STARTED
[23:10:15.324] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:7:0) after 1m32s
[23:11:47.390] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:7:0)
[23:11:47.441] Build status: STARTED
[23:11:47.441] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:8:0) after 9m40s
[23:21:27.645] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:8:0)
[23:21:27.708] Build status: STARTED
[23:21:27.708] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:9:0) after 6m22s
[23:27:49.692] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:9:0)
[23:27:49.752] Build status: STARTED
[23:27:49.752] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:10:0) after 7m27s
[23:35:16.815] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:10:0)
[23:35:16.845] Build status: STARTED
[23:35:16.845] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:11:0) after 3m46s
[23:39:02.942] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:11:0)
[23:39:02.957] Build status: STARTED
[23:39:02.957] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:12:0) after 1m36s
[23:40:38.944] Handling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:12:0)
[23:40:38.960] Build status: STARTED
[23:40:38.960] Scheduling timer "check-buildbucket-build-status" (chromium-m140/linux-cast-x64-dbg:8871407456629277056:13:0) after 6m17s
[23:42:20.045] Received PubSub notification, asking Buildbucket for the build status
[23:42:20.113] Build:
{
"id": "8705977394624284705",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 424,
"createdBy": "project:chromium-m140",
"createTime": "2025-08-20T22:46:21.741886045Z",
"startTime": "2025-08-20T22:46:27.388069688Z",
"endTime": "2025-08-20T23:42:19.714662781Z",
"updateTime": "2025-08-20T23:42:19.714662781Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e157b32f17200a16d0950f166564765c3cc028db",
"ref": "refs/branch-heads/7339"
}
}
}
[23:42:20.113] Invocation finished in 55m59.668459273s with status SUCCEEDED