[20:27:25.751] New invocation is queued and will start shortly
[20:27:26.879] Starting the invocation (attempt 1)
[20:27:26.912] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f8f8295fe2da3c7370508b8c0bfd376cf76a28ef"
[20:27:26.912] Popped gitiles commit info from properties and tags
[20:27:26.912] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:27:26.913] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:27:26.913] Buildbucket request:
{
"requestId": "8875130671825634288",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875130671825634288",
"job": "chromium-m139/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1bf183b617626ecf25fd8cf53aed4bf397958dac"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@1bf183b617626ecf25fd8cf53aed4bf397958dac",
"title": "1bf183b617626ecf25fd8cf53aed4bf397958dac",
"url": "https://chromium.googlesource.com/chromium/src/+/1bf183b617626ecf25fd8cf53aed4bf397958dac"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "33fa47b5bc9a133b8e716145a5aaa06894e332fe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@33fa47b5bc9a133b8e716145a5aaa06894e332fe",
"title": "33fa47b5bc9a133b8e716145a5aaa06894e332fe",
"url": "https://chromium.googlesource.com/chromium/src/+/33fa47b5bc9a133b8e716145a5aaa06894e332fe"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "12778f1580afb6777bc0f632718e529b8b008363"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@12778f1580afb6777bc0f632718e529b8b008363",
"title": "12778f1580afb6777bc0f632718e529b8b008363",
"url": "https://chromium.googlesource.com/chromium/src/+/12778f1580afb6777bc0f632718e529b8b008363"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c61cd5b79fa23bc9f682fadf827ed3a5fcec69a8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@c61cd5b79fa23bc9f682fadf827ed3a5fcec69a8",
"title": "c61cd5b79fa23bc9f682fadf827ed3a5fcec69a8",
"url": "https://chromium.googlesource.com/chromium/src/+/c61cd5b79fa23bc9f682fadf827ed3a5fcec69a8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aede4f8a73d37f11491ca2307cddc947166439e1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@aede4f8a73d37f11491ca2307cddc947166439e1",
"title": "aede4f8a73d37f11491ca2307cddc947166439e1",
"url": "https://chromium.googlesource.com/chromium/src/+/aede4f8a73d37f11491ca2307cddc947166439e1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "162d92273c0dc580c041bf2d9daffe9138f7003c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@162d92273c0dc580c041bf2d9daffe9138f7003c",
"title": "162d92273c0dc580c041bf2d9daffe9138f7003c",
"url": "https://chromium.googlesource.com/chromium/src/+/162d92273c0dc580c041bf2d9daffe9138f7003c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ede6de2caaa3f526a6737ab99f996bae23917db5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@ede6de2caaa3f526a6737ab99f996bae23917db5",
"title": "ede6de2caaa3f526a6737ab99f996bae23917db5",
"url": "https://chromium.googlesource.com/chromium/src/+/ede6de2caaa3f526a6737ab99f996bae23917db5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "43734c6c44ac970aefef523378f81d87dca54c6d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@43734c6c44ac970aefef523378f81d87dca54c6d",
"title": "43734c6c44ac970aefef523378f81d87dca54c6d",
"url": "https://chromium.googlesource.com/chromium/src/+/43734c6c44ac970aefef523378f81d87dca54c6d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f8f8295fe2da3c7370508b8c0bfd376cf76a28ef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@f8f8295fe2da3c7370508b8c0bfd376cf76a28ef",
"title": "f8f8295fe2da3c7370508b8c0bfd376cf76a28ef",
"url": "https://chromium.googlesource.com/chromium/src/+/f8f8295fe2da3c7370508b8c0bfd376cf76a28ef"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f8f8295fe2da3c7370508b8c0bfd376cf76a28ef",
"ref": "refs/branch-heads/7258"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875130671825634288"
},
{
"key": "scheduler_job_id",
"value": "chromium-m139/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:27:27.464] Scheduled build:
{
"id": "8709700609816684833",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 194,
"createdBy": "project:chromium-m139",
"createTime": "2025-07-10T20:27:27.037481451Z",
"updateTime": "2025-07-10T20:27:27.037481451Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f8f8295fe2da3c7370508b8c0bfd376cf76a28ef",
"ref": "refs/branch-heads/7258"
}
}
}
[20:27:27.464] Task URL: https://cr-buildbucket.appspot.com/build/8709700609816684833
[20:27:27.464] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:2:0) after 6m31s
[20:27:28.467] Received PubSub notification, asking Buildbucket for the build status
[20:27:28.656] Build status: SCHEDULED
[20:33:58.536] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:2:0)
[20:33:58.591] Build status: SCHEDULED
[20:33:58.591] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:4:0) after 6m37s
[20:40:35.609] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:4:0)
[20:40:35.637] Build status: SCHEDULED
[20:40:35.637] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:5:0) after 1m49s
[20:42:24.745] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:5:0)
[20:42:24.762] Build status: SCHEDULED
[20:42:24.762] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:6:0) after 7m31s
[20:49:55.907] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:6:0)
[20:49:55.928] Build status: SCHEDULED
[20:49:55.928] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:7:0) after 4m41s
[20:54:37.001] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:7:0)
[20:54:37.048] Build status: SCHEDULED
[20:54:37.048] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:8:0) after 8m1s
[21:02:38.079] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:8:0)
[21:02:38.111] Build status: SCHEDULED
[21:02:38.111] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:9:0) after 7m22s
[21:10:00.130] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:9:0)
[21:10:00.198] Build status: SCHEDULED
[21:10:00.198] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:10:0) after 5m49s
[21:15:49.272] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:10:0)
[21:15:49.395] Build status: SCHEDULED
[21:15:49.396] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:11:0) after 5m42s
[21:21:31.433] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:11:0)
[21:21:31.584] Build status: SCHEDULED
[21:21:31.584] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:12:0) after 3m59s
[21:22:01.991] Received PubSub notification, asking Buildbucket for the build status
[21:22:02.009] Build status: STARTED
[21:25:30.611] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:12:0)
[21:25:30.633] Build status: STARTED
[21:25:30.633] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:14:0) after 7m12s
[21:32:42.654] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:14:0)
[21:32:42.668] Build status: STARTED
[21:32:42.668] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:15:0) after 3m21s
[21:36:03.727] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:15:0)
[21:36:03.824] Build status: STARTED
[21:36:03.824] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:16:0) after 7m48s
[21:43:52.117] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:16:0)
[21:43:52.217] Build status: STARTED
[21:43:52.217] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:17:0) after 3m33s
[21:47:25.278] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:17:0)
[21:47:25.299] Build status: STARTED
[21:47:25.299] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:18:0) after 4m33s
[21:51:58.323] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:18:0)
[21:51:58.437] Build status: STARTED
[21:51:58.438] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:19:0) after 5m38s
[21:57:36.525] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:19:0)
[21:57:36.546] Build status: STARTED
[21:57:36.546] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:20:0) after 9m10s
[22:06:46.679] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:20:0)
[22:06:46.718] Build status: STARTED
[22:06:46.718] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:21:0) after 5m22s
[22:12:08.820] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:21:0)
[22:12:08.927] Build status: STARTED
[22:12:08.927] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:22:0) after 5m36s
[22:17:44.965] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:22:0)
[22:17:44.982] Build status: STARTED
[22:17:44.982] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:23:0) after 1m20s
[22:19:05.124] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:23:0)
[22:19:05.235] Build status: STARTED
[22:19:05.235] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:24:0) after 7m0s
[22:26:05.462] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:24:0)
[22:26:05.480] Build status: STARTED
[22:26:05.481] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:25:0) after 4m49s
[22:30:54.510] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:25:0)
[22:30:54.538] Build status: STARTED
[22:30:54.538] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:26:0) after 3m55s
[22:34:49.618] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:26:0)
[22:34:49.638] Build status: STARTED
[22:34:49.638] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:27:0) after 1m46s
[22:36:35.744] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:27:0)
[22:36:35.764] Build status: STARTED
[22:36:35.764] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:28:0) after 3m56s
[22:40:31.834] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:28:0)
[22:40:31.882] Build status: STARTED
[22:40:31.882] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:29:0) after 7m16s
[22:47:47.896] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:29:0)
[22:47:47.915] Build status: STARTED
[22:47:47.916] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8875130671825634288:30:0) after 7m52s
[22:54:41.461] Received PubSub notification, asking Buildbucket for the build status
[22:54:41.479] Build:
{
"id": "8709700609816684833",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 194,
"createdBy": "project:chromium-m139",
"createTime": "2025-07-10T20:27:27.037481451Z",
"startTime": "2025-07-10T21:22:01.767771806Z",
"endTime": "2025-07-10T22:54:40.948303326Z",
"updateTime": "2025-07-10T22:54:40.948303326Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f8f8295fe2da3c7370508b8c0bfd376cf76a28ef",
"ref": "refs/branch-heads/7258"
}
}
}
[22:54:41.479] Invocation finished in 2h27m15.740983394s with status SUCCEEDED