[21:25:15.165] New invocation is queued and will start shortly
[21:25:16.231] Starting the invocation (attempt 1)
[21:25:16.256] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2703df3916e2ed90308178fe50cd1ace8242b72f"
[21:25:16.256] Popped gitiles commit info from properties and tags
[21:25:16.256] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:25:16.259] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:25:16.259] Buildbucket request:
{
"requestId": "8893971202885128960",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "Linux Builder"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893971202885128960",
"job": "chromium-m131/Linux Builder",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c96660bea8acdb6a436ce2d0ad3b46cf77a4a3a6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@c96660bea8acdb6a436ce2d0ad3b46cf77a4a3a6",
"title": "c96660bea8acdb6a436ce2d0ad3b46cf77a4a3a6",
"url": "https://chromium.googlesource.com/chromium/src/+/c96660bea8acdb6a436ce2d0ad3b46cf77a4a3a6"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d9398c8bc42e1a775fcec75378d7e3a9ae17c345"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@d9398c8bc42e1a775fcec75378d7e3a9ae17c345",
"title": "d9398c8bc42e1a775fcec75378d7e3a9ae17c345",
"url": "https://chromium.googlesource.com/chromium/src/+/d9398c8bc42e1a775fcec75378d7e3a9ae17c345"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "21f2b121326ba60f8eb42960b67801fcf671bb67"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@21f2b121326ba60f8eb42960b67801fcf671bb67",
"title": "21f2b121326ba60f8eb42960b67801fcf671bb67",
"url": "https://chromium.googlesource.com/chromium/src/+/21f2b121326ba60f8eb42960b67801fcf671bb67"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "46ca64863a896791fd83c71d5803db93e9ae7934"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@46ca64863a896791fd83c71d5803db93e9ae7934",
"title": "46ca64863a896791fd83c71d5803db93e9ae7934",
"url": "https://chromium.googlesource.com/chromium/src/+/46ca64863a896791fd83c71d5803db93e9ae7934"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "52718c25c57a971c9f3c568b68ed5132b7862f72"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@52718c25c57a971c9f3c568b68ed5132b7862f72",
"title": "52718c25c57a971c9f3c568b68ed5132b7862f72",
"url": "https://chromium.googlesource.com/chromium/src/+/52718c25c57a971c9f3c568b68ed5132b7862f72"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "360dc948092d19208eb1d93f0ee8e4b96841460c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@360dc948092d19208eb1d93f0ee8e4b96841460c",
"title": "360dc948092d19208eb1d93f0ee8e4b96841460c",
"url": "https://chromium.googlesource.com/chromium/src/+/360dc948092d19208eb1d93f0ee8e4b96841460c"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2703df3916e2ed90308178fe50cd1ace8242b72f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@2703df3916e2ed90308178fe50cd1ace8242b72f",
"title": "2703df3916e2ed90308178fe50cd1ace8242b72f",
"url": "https://chromium.googlesource.com/chromium/src/+/2703df3916e2ed90308178fe50cd1ace8242b72f"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2703df3916e2ed90308178fe50cd1ace8242b72f",
"ref": "refs/branch-heads/6778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893971202885128960"
},
{
"key": "scheduler_job_id",
"value": "chromium-m131/Linux Builder"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:25:17.155] Scheduled build:
{
"id": "8728541140987617601",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "Linux Builder"
},
"number": 1445,
"createdBy": "project:chromium-m131",
"createTime": "2024-12-14T21:25:16.352782463Z",
"updateTime": "2024-12-14T21:25:16.352782463Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2703df3916e2ed90308178fe50cd1ace8242b72f",
"ref": "refs/branch-heads/6778"
}
}
}
[21:25:17.155] Task URL: https://cr-buildbucket.appspot.com/build/8728541140987617601
[21:25:17.155] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:2:0) after 7m57s
[21:25:17.918] Received PubSub notification, asking Buildbucket for the build status
[21:25:17.940] Build status: SCHEDULED
[21:33:14.168] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:2:0)
[21:33:14.187] Build status: SCHEDULED
[21:33:14.187] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:4:0) after 2m12s
[21:33:39.851] Received PubSub notification, asking Buildbucket for the build status
[21:33:39.879] Build status: STARTED
[21:35:26.303] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:4:0)
[21:35:26.450] Build status: STARTED
[21:35:26.450] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:6:0) after 5m52s
[21:41:18.520] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:6:0)
[21:41:18.550] Build status: STARTED
[21:41:18.550] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:7:0) after 1m1s
[21:42:19.570] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:7:0)
[21:42:19.592] Build status: STARTED
[21:42:19.592] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:8:0) after 4m11s
[21:46:30.606] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:8:0)
[21:46:30.635] Build status: STARTED
[21:46:30.635] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:9:0) after 6m35s
[21:53:05.651] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:9:0)
[21:53:05.811] Build status: STARTED
[21:53:05.811] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:10:0) after 2m56s
[21:56:02.000] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:10:0)
[21:56:02.016] Build status: STARTED
[21:56:02.016] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:11:0) after 1m50s
[21:57:52.030] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:11:0)
[21:57:52.044] Build status: STARTED
[21:57:52.044] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:12:0) after 2m17s
[22:00:09.144] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:12:0)
[22:00:09.165] Build status: STARTED
[22:00:09.165] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:13:0) after 2m8s
[22:02:17.257] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:13:0)
[22:02:17.281] Build status: STARTED
[22:02:17.281] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:14:0) after 4m7s
[22:06:24.325] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:14:0)
[22:06:24.366] Build status: STARTED
[22:06:24.366] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:15:0) after 9m9s
[22:15:33.474] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:15:0)
[22:15:33.488] Build status: STARTED
[22:15:33.488] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:16:0) after 9m59s
[22:25:32.674] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:16:0)
[22:25:32.689] Build status: STARTED
[22:25:32.689] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:17:0) after 7m18s
[22:32:50.707] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:17:0)
[22:32:50.725] Build status: STARTED
[22:32:50.725] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:18:0) after 2m37s
[22:35:27.775] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:18:0)
[22:35:27.806] Build status: STARTED
[22:35:27.806] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:19:0) after 5m26s
[22:40:53.915] Handling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:19:0)
[22:40:53.938] Build status: STARTED
[22:40:53.938] Scheduling timer "check-buildbucket-build-status" (chromium-m131/Linux Builder:8893971202885128960:20:0) after 7m6s
[22:43:16.801] Received PubSub notification, asking Buildbucket for the build status
[22:43:16.833] Build:
{
"id": "8728541140987617601",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "Linux Builder"
},
"number": 1445,
"createdBy": "project:chromium-m131",
"createTime": "2024-12-14T21:25:16.352782463Z",
"startTime": "2024-12-14T21:33:39.633087800Z",
"endTime": "2024-12-14T22:42:50.248223286Z",
"updateTime": "2024-12-14T22:42:50.248223286Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2703df3916e2ed90308178fe50cd1ace8242b72f",
"ref": "refs/branch-heads/6778"
}
}
}
[22:43:16.833] Invocation finished in 1h18m1.674927794s with status SUCCEEDED