[17:36:27.105] New invocation is queued and will start shortly
[17:36:28.126] Starting the invocation (attempt 1)
[17:36:28.150] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fac97d839f5ad545c132c3c25ce90f73d5f478bc"
[17:36:28.150] Popped gitiles commit info from properties and tags
[17:36:28.150] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:36:28.150] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:36:28.151] Buildbucket request:
{
"requestId": "8877678143853726496",
"builder": {
"project": "chromium-m137",
"bucket": "ci",
"builder": "android-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8877678143853726496",
"job": "chromium-m137/android-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f28a3d3f3017fe28fadc3e948369dcbd59caec65"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@f28a3d3f3017fe28fadc3e948369dcbd59caec65",
"title": "f28a3d3f3017fe28fadc3e948369dcbd59caec65",
"url": "https://chromium.googlesource.com/chromium/src/+/f28a3d3f3017fe28fadc3e948369dcbd59caec65"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2ec877b51ed5b10f020d91a9814dda7509a62f44"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@2ec877b51ed5b10f020d91a9814dda7509a62f44",
"title": "2ec877b51ed5b10f020d91a9814dda7509a62f44",
"url": "https://chromium.googlesource.com/chromium/src/+/2ec877b51ed5b10f020d91a9814dda7509a62f44"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b680f511a9ea83cd921e99e725da315cd331da01"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@b680f511a9ea83cd921e99e725da315cd331da01",
"title": "b680f511a9ea83cd921e99e725da315cd331da01",
"url": "https://chromium.googlesource.com/chromium/src/+/b680f511a9ea83cd921e99e725da315cd331da01"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6c61e4b93abc42d22a64f007e6ddcdf45ff88403"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@6c61e4b93abc42d22a64f007e6ddcdf45ff88403",
"title": "6c61e4b93abc42d22a64f007e6ddcdf45ff88403",
"url": "https://chromium.googlesource.com/chromium/src/+/6c61e4b93abc42d22a64f007e6ddcdf45ff88403"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8c023cf6dd233a0c91faca5068bc2ab8fad7c2d9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@8c023cf6dd233a0c91faca5068bc2ab8fad7c2d9",
"title": "8c023cf6dd233a0c91faca5068bc2ab8fad7c2d9",
"url": "https://chromium.googlesource.com/chromium/src/+/8c023cf6dd233a0c91faca5068bc2ab8fad7c2d9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fac97d839f5ad545c132c3c25ce90f73d5f478bc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@fac97d839f5ad545c132c3c25ce90f73d5f478bc",
"title": "fac97d839f5ad545c132c3c25ce90f73d5f478bc",
"url": "https://chromium.googlesource.com/chromium/src/+/fac97d839f5ad545c132c3c25ce90f73d5f478bc"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fac97d839f5ad545c132c3c25ce90f73d5f478bc",
"ref": "refs/branch-heads/7151"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8877678143853726496"
},
{
"key": "scheduler_job_id",
"value": "chromium-m137/android-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:36:28.683] Scheduled build:
{
"id": "8712248082043321073",
"builder": {
"project": "chromium-m137",
"bucket": "ci",
"builder": "android-official"
},
"number": 525,
"createdBy": "project:chromium-m137",
"createTime": "2025-06-12T17:36:28.203816409Z",
"updateTime": "2025-06-12T17:36:28.203816409Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fac97d839f5ad545c132c3c25ce90f73d5f478bc",
"ref": "refs/branch-heads/7151"
}
}
}
[17:36:28.683] Task URL: https://cr-buildbucket.appspot.com/build/8712248082043321073
[17:36:28.684] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:2:0) after 3m59s
[17:36:29.725] Received PubSub notification, asking Buildbucket for the build status
[17:36:29.764] Build status: SCHEDULED
[17:36:32.393] Received PubSub notification, asking Buildbucket for the build status
[17:36:32.416] Build status: STARTED
[17:40:27.785] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:2:0)
[17:40:27.808] Build status: STARTED
[17:40:27.808] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:5:0) after 6m2s
[17:46:29.826] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:5:0)
[17:46:29.873] Build status: STARTED
[17:46:29.873] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:6:0) after 6m15s
[17:52:44.893] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:6:0)
[17:52:44.915] Build status: STARTED
[17:52:44.915] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:7:0) after 4m22s
[17:57:06.929] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:7:0)
[17:57:06.951] Build status: STARTED
[17:57:06.951] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:8:0) after 4m19s
[18:01:25.967] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:8:0)
[18:01:30.997] Build status: STARTED
[18:01:30.997] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:9:0) after 9m48s
[18:11:19.085] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:9:0)
[18:11:24.118] Build status: STARTED
[18:11:24.118] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:10:0) after 6m42s
[18:18:06.138] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:10:0)
[18:18:11.187] Build status: STARTED
[18:18:11.187] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:11:0) after 2m39s
[18:20:50.199] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:11:0)
[18:20:55.231] Build status: STARTED
[18:20:55.231] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:12:0) after 4m0s
[18:24:55.243] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:12:0)
[18:25:00.329] Build status: STARTED
[18:25:00.329] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:13:0) after 9m23s
[18:34:23.603] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:13:0)
[18:34:33.744] Build status: STARTED
[18:34:33.744] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:14:0) after 6m55s
[18:41:29.522] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:14:0)
[18:41:34.760] Build status: STARTED
[18:41:34.760] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:15:0) after 1m37s
[18:43:11.775] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:15:0)
[18:43:14.281] Build status: STARTED
[18:43:14.281] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:16:0) after 1m32s
[18:44:46.338] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:16:0)
[18:44:46.377] Build status: STARTED
[18:44:46.377] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:17:0) after 5m49s
[18:50:39.592] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:17:0)
[18:50:39.618] Build status: STARTED
[18:50:39.618] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:18:0) after 7m24s
[18:58:03.761] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:18:0)
[18:58:03.778] Build status: STARTED
[18:58:03.778] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:19:0) after 8m57s
[19:07:00.758] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:19:0)
[19:07:00.825] Build status: STARTED
[19:07:00.825] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:20:0) after 4m23s
[19:11:24.188] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:20:0)
[19:11:24.216] Build status: STARTED
[19:11:24.216] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:21:0) after 9m19s
[19:20:47.213] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:21:0)
[19:20:47.240] Build status: STARTED
[19:20:47.240] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:22:0) after 4m56s
[19:25:44.036] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:22:0)
[19:25:44.064] Build status: STARTED
[19:25:44.064] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:23:0) after 6m59s
[19:32:43.556] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:23:0)
[19:32:43.860] Build status: STARTED
[19:32:43.860] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:24:0) after 8m35s
[20:14:47.932] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:24:0)
[20:14:48.004] Build status: STARTED
[20:14:48.004] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:25:0) after 1m2s
[20:15:50.235] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:25:0)
[20:15:50.273] Build status: STARTED
[20:15:50.273] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:26:0) after 3m24s
[20:19:14.251] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:26:0)
[20:19:14.277] Build status: STARTED
[20:19:14.277] Scheduling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:27:0) after 6m23s
[20:25:37.291] Handling timer "check-buildbucket-build-status" (chromium-m137/android-official:8877678143853726496:27:0)
[20:25:37.364] Build:
{
"id": "8712248082043321073",
"builder": {
"project": "chromium-m137",
"bucket": "ci",
"builder": "android-official"
},
"number": 525,
"createdBy": "project:chromium-m137",
"createTime": "2025-06-12T17:36:28.203816409Z",
"startTime": "2025-06-12T17:36:32.205098606Z",
"endTime": "2025-06-12T20:24:05.843646647Z",
"updateTime": "2025-06-12T20:24:05.843646647Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fac97d839f5ad545c132c3c25ce90f73d5f478bc",
"ref": "refs/branch-heads/7151"
}
}
}
[20:25:37.365] Invocation finished in 2h49m10.27166894s with status SUCCEEDED