[20:31:24.464] New invocation is queued and will start shortly
[20:31:25.539] Starting the invocation (attempt 1)
[20:31:25.566] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d274a758782bd4e4a6810536963e3c100b7b738a"
[20:31:25.566] Popped gitiles commit info from properties and tags
[20:31:25.566] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:31:25.566] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:31:25.566] Buildbucket request:
{
"requestId": "8888629369500709632",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888629369500709632",
"job": "chromium-m134/fuchsia-x64-cast-receiver-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "459940dd4f20a9a8933155253f2425682369e755"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@459940dd4f20a9a8933155253f2425682369e755",
"title": "459940dd4f20a9a8933155253f2425682369e755",
"url": "https://chromium.googlesource.com/chromium/src/+/459940dd4f20a9a8933155253f2425682369e755"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9beee73aad4542c1c9e82762f18fdfa3e00b0b2a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@9beee73aad4542c1c9e82762f18fdfa3e00b0b2a",
"title": "9beee73aad4542c1c9e82762f18fdfa3e00b0b2a",
"url": "https://chromium.googlesource.com/chromium/src/+/9beee73aad4542c1c9e82762f18fdfa3e00b0b2a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "481e659b996b59f6b82df6a9daafdd615b1c9572"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@481e659b996b59f6b82df6a9daafdd615b1c9572",
"title": "481e659b996b59f6b82df6a9daafdd615b1c9572",
"url": "https://chromium.googlesource.com/chromium/src/+/481e659b996b59f6b82df6a9daafdd615b1c9572"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "915b3cd93e848e88ca5d0e7888614ac368ddc6d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@915b3cd93e848e88ca5d0e7888614ac368ddc6d3",
"title": "915b3cd93e848e88ca5d0e7888614ac368ddc6d3",
"url": "https://chromium.googlesource.com/chromium/src/+/915b3cd93e848e88ca5d0e7888614ac368ddc6d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9cf7a92e906d4e3172e74fde48a24976f4c650f0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@9cf7a92e906d4e3172e74fde48a24976f4c650f0",
"title": "9cf7a92e906d4e3172e74fde48a24976f4c650f0",
"url": "https://chromium.googlesource.com/chromium/src/+/9cf7a92e906d4e3172e74fde48a24976f4c650f0"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ed5ed4f2c96f2b06e2fa26c046ceb81af7f16468"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@ed5ed4f2c96f2b06e2fa26c046ceb81af7f16468",
"title": "ed5ed4f2c96f2b06e2fa26c046ceb81af7f16468",
"url": "https://chromium.googlesource.com/chromium/src/+/ed5ed4f2c96f2b06e2fa26c046ceb81af7f16468"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0986e531c76180ec8dd175c79ef816af2510c31a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@0986e531c76180ec8dd175c79ef816af2510c31a",
"title": "0986e531c76180ec8dd175c79ef816af2510c31a",
"url": "https://chromium.googlesource.com/chromium/src/+/0986e531c76180ec8dd175c79ef816af2510c31a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "825923c79f56e6553feffa6a0e93a522901cfa11"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@825923c79f56e6553feffa6a0e93a522901cfa11",
"title": "825923c79f56e6553feffa6a0e93a522901cfa11",
"url": "https://chromium.googlesource.com/chromium/src/+/825923c79f56e6553feffa6a0e93a522901cfa11"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2d2106e6edac4c7da92e0b0aeb07f1618d2e6845"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@2d2106e6edac4c7da92e0b0aeb07f1618d2e6845",
"title": "2d2106e6edac4c7da92e0b0aeb07f1618d2e6845",
"url": "https://chromium.googlesource.com/chromium/src/+/2d2106e6edac4c7da92e0b0aeb07f1618d2e6845"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e4cc7e9679cd5493a4c93c76530bfb7eedec76ef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@e4cc7e9679cd5493a4c93c76530bfb7eedec76ef",
"title": "e4cc7e9679cd5493a4c93c76530bfb7eedec76ef",
"url": "https://chromium.googlesource.com/chromium/src/+/e4cc7e9679cd5493a4c93c76530bfb7eedec76ef"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3e853ca58ddd4d72b1e08aa0b4cb79b83d4beac9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@3e853ca58ddd4d72b1e08aa0b4cb79b83d4beac9",
"title": "3e853ca58ddd4d72b1e08aa0b4cb79b83d4beac9",
"url": "https://chromium.googlesource.com/chromium/src/+/3e853ca58ddd4d72b1e08aa0b4cb79b83d4beac9"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "99a5f5ede21329fe5af04cc41ea44d19a01b6bac"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@99a5f5ede21329fe5af04cc41ea44d19a01b6bac",
"title": "99a5f5ede21329fe5af04cc41ea44d19a01b6bac",
"url": "https://chromium.googlesource.com/chromium/src/+/99a5f5ede21329fe5af04cc41ea44d19a01b6bac"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "68fd4260ee033500875fb6210c68112d73857e0a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@68fd4260ee033500875fb6210c68112d73857e0a",
"title": "68fd4260ee033500875fb6210c68112d73857e0a",
"url": "https://chromium.googlesource.com/chromium/src/+/68fd4260ee033500875fb6210c68112d73857e0a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d274a758782bd4e4a6810536963e3c100b7b738a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@d274a758782bd4e4a6810536963e3c100b7b738a",
"title": "d274a758782bd4e4a6810536963e3c100b7b738a",
"url": "https://chromium.googlesource.com/chromium/src/+/d274a758782bd4e4a6810536963e3c100b7b738a"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d274a758782bd4e4a6810536963e3c100b7b738a",
"ref": "refs/branch-heads/6998"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888629369500709632"
},
{
"key": "scheduler_job_id",
"value": "chromium-m134/fuchsia-x64-cast-receiver-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:31:26.049] Scheduled build:
{
"id": "8723199307644922657",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 77,
"createdBy": "project:chromium-m134",
"createTime": "2025-02-11T20:31:25.614531419Z",
"updateTime": "2025-02-11T20:31:25.614531419Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d274a758782bd4e4a6810536963e3c100b7b738a",
"ref": "refs/branch-heads/6998"
}
}
}
[20:31:26.049] Task URL: https://cr-buildbucket.appspot.com/build/8723199307644922657
[20:31:26.049] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:2:0) after 9m23s
[20:31:26.299] Received PubSub notification, asking Buildbucket for the build status
[20:31:26.321] Build status: SCHEDULED
[20:40:49.073] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:2:0)
[20:40:49.113] Build status: SCHEDULED
[20:40:49.113] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:4:0) after 4m34s
[20:45:23.138] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:4:0)
[20:45:23.172] Build status: SCHEDULED
[20:45:23.172] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:5:0) after 4m44s
[20:50:07.171] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:5:0)
[20:50:07.230] Build status: SCHEDULED
[20:50:07.230] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:6:0) after 4m23s
[20:54:30.228] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:6:0)
[20:54:30.250] Build status: SCHEDULED
[20:54:30.250] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:7:0) after 6m30s
[21:01:00.323] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:7:0)
[21:01:00.368] Build status: SCHEDULED
[21:01:00.368] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:8:0) after 4m41s
[21:05:41.413] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:8:0)
[21:05:41.438] Build status: SCHEDULED
[21:05:41.438] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:9:0) after 1m3s
[21:06:44.428] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:9:0)
[21:06:44.492] Build status: SCHEDULED
[21:06:44.492] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:10:0) after 8m17s
[21:15:01.519] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:10:0)
[21:15:01.541] Build status: SCHEDULED
[21:15:01.541] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:11:0) after 7m42s
[21:21:23.999] Received PubSub notification, asking Buildbucket for the build status
[21:21:24.045] Build status: STARTED
[21:22:43.601] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:11:0)
[21:22:43.622] Build status: STARTED
[21:22:43.622] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:13:0) after 3m21s
[21:26:04.641] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:13:0)
[21:26:04.659] Build status: STARTED
[21:26:04.659] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:14:0) after 5m49s
[21:31:53.708] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:14:0)
[21:31:53.735] Build status: STARTED
[21:31:53.735] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:15:0) after 7m48s
[21:39:42.029] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:15:0)
[21:39:42.051] Build status: STARTED
[21:39:42.051] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:16:0) after 1m59s
[21:41:41.244] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:16:0)
[21:41:41.286] Build status: STARTED
[21:41:41.286] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:17:0) after 6m41s
[21:48:22.307] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:17:0)
[21:48:22.330] Build status: STARTED
[21:48:22.330] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:18:0) after 7m12s
[21:55:34.420] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:18:0)
[21:55:34.435] Build status: STARTED
[21:55:34.435] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:19:0) after 6m17s
[22:01:51.456] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:19:0)
[22:01:51.523] Build status: STARTED
[22:01:51.523] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:20:0) after 1m35s
[22:03:26.590] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:20:0)
[22:03:26.608] Build status: STARTED
[22:03:26.608] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:21:0) after 9m19s
[22:12:45.654] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:21:0)
[22:12:45.760] Build status: STARTED
[22:12:45.760] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:22:0) after 7m33s
[22:20:18.782] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:22:0)
[22:20:18.798] Build status: STARTED
[22:20:18.798] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:23:0) after 6m37s
[22:26:55.866] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:23:0)
[22:26:55.890] Build status: STARTED
[22:26:55.890] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:24:0) after 3m19s
[22:30:14.932] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:24:0)
[22:30:15.024] Build status: STARTED
[22:30:15.024] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:25:0) after 7m26s
[22:37:41.049] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:25:0)
[22:37:41.079] Build status: STARTED
[22:37:41.079] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:26:0) after 1m15s
[22:38:56.103] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:26:0)
[22:38:56.119] Build status: STARTED
[22:38:56.119] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:27:0) after 4m6s
[22:43:02.136] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:27:0)
[22:43:02.176] Build status: STARTED
[22:43:02.176] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:28:0) after 2m21s
[22:45:23.232] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:28:0)
[22:45:23.268] Build status: STARTED
[22:45:23.268] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:29:0) after 5m26s
[22:50:49.256] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:29:0)
[22:50:49.283] Build status: STARTED
[22:50:49.283] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:30:0) after 7m2s
[22:57:51.311] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:30:0)
[22:57:51.329] Build status: STARTED
[22:57:51.329] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:31:0) after 5m55s
[23:03:46.404] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:31:0)
[23:03:46.426] Build status: STARTED
[23:03:46.426] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8888629369500709632:32:0) after 5m9s
[23:05:23.008] Received PubSub notification, asking Buildbucket for the build status
[23:05:23.026] Build:
{
"id": "8723199307644922657",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 77,
"createdBy": "project:chromium-m134",
"createTime": "2025-02-11T20:31:25.614531419Z",
"startTime": "2025-02-11T21:21:23.801394483Z",
"endTime": "2025-02-11T23:05:21.712605921Z",
"updateTime": "2025-02-11T23:05:21.712605921Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d274a758782bd4e4a6810536963e3c100b7b738a",
"ref": "refs/branch-heads/6998"
}
}
}
[23:05:23.026] Invocation finished in 2h33m58.565580798s with status SUCCEEDED