[05:41:31.093] New invocation is queued and will start shortly
[05:41:32.521] Starting the invocation (attempt 1)
[05:41:32.547] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71040c4058ed04bdfdf3755781d2795795345bb2"
[05:41:32.548] Popped gitiles commit info from properties and tags
[05:41:32.548] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:41:32.548] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:41:32.548] Buildbucket request:
{
"requestId": "8836773294761661200",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "android-desktop-arm64-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836773294761661200",
"job": "chromium-m154/android-desktop-arm64-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3317be499811f7edb8692889c8d02c7250b9cd2f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@3317be499811f7edb8692889c8d02c7250b9cd2f",
"title": "3317be499811f7edb8692889c8d02c7250b9cd2f",
"url": "https://chromium.googlesource.com/chromium/src/+/3317be499811f7edb8692889c8d02c7250b9cd2f"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a1d6f0230c38385d990105d60fcba82afdb073d7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@a1d6f0230c38385d990105d60fcba82afdb073d7",
"title": "a1d6f0230c38385d990105d60fcba82afdb073d7",
"url": "https://chromium.googlesource.com/chromium/src/+/a1d6f0230c38385d990105d60fcba82afdb073d7"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b110230ecb8fd072dd7a919409e57c301afa8aeb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@b110230ecb8fd072dd7a919409e57c301afa8aeb",
"title": "b110230ecb8fd072dd7a919409e57c301afa8aeb",
"url": "https://chromium.googlesource.com/chromium/src/+/b110230ecb8fd072dd7a919409e57c301afa8aeb"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1635081715f60f981423e1dd806c243b49e49e99"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@1635081715f60f981423e1dd806c243b49e49e99",
"title": "1635081715f60f981423e1dd806c243b49e49e99",
"url": "https://chromium.googlesource.com/chromium/src/+/1635081715f60f981423e1dd806c243b49e49e99"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9434f1f3273ae888bf2614f45a369ab1710ea081"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@9434f1f3273ae888bf2614f45a369ab1710ea081",
"title": "9434f1f3273ae888bf2614f45a369ab1710ea081",
"url": "https://chromium.googlesource.com/chromium/src/+/9434f1f3273ae888bf2614f45a369ab1710ea081"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e6ab66b2b6a4d26d8cadba53b6f3768523c0f178"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@e6ab66b2b6a4d26d8cadba53b6f3768523c0f178",
"title": "e6ab66b2b6a4d26d8cadba53b6f3768523c0f178",
"url": "https://chromium.googlesource.com/chromium/src/+/e6ab66b2b6a4d26d8cadba53b6f3768523c0f178"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e69d000fc3c916b6b7af6ee72a1078e2624f98be"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@e69d000fc3c916b6b7af6ee72a1078e2624f98be",
"title": "e69d000fc3c916b6b7af6ee72a1078e2624f98be",
"url": "https://chromium.googlesource.com/chromium/src/+/e69d000fc3c916b6b7af6ee72a1078e2624f98be"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0f024118fe5ce5672167f186835f5e44c42398e8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@0f024118fe5ce5672167f186835f5e44c42398e8",
"title": "0f024118fe5ce5672167f186835f5e44c42398e8",
"url": "https://chromium.googlesource.com/chromium/src/+/0f024118fe5ce5672167f186835f5e44c42398e8"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1b3e634d15902b6c4582e342995e2526e8b89629"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@1b3e634d15902b6c4582e342995e2526e8b89629",
"title": "1b3e634d15902b6c4582e342995e2526e8b89629",
"url": "https://chromium.googlesource.com/chromium/src/+/1b3e634d15902b6c4582e342995e2526e8b89629"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "06a5bef59d104129ceb86d151f9076d049bb0123"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@06a5bef59d104129ceb86d151f9076d049bb0123",
"title": "06a5bef59d104129ceb86d151f9076d049bb0123",
"url": "https://chromium.googlesource.com/chromium/src/+/06a5bef59d104129ceb86d151f9076d049bb0123"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c1868079d26266a7963dc895be853925dc96aae9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@c1868079d26266a7963dc895be853925dc96aae9",
"title": "c1868079d26266a7963dc895be853925dc96aae9",
"url": "https://chromium.googlesource.com/chromium/src/+/c1868079d26266a7963dc895be853925dc96aae9"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "71040c4058ed04bdfdf3755781d2795795345bb2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@71040c4058ed04bdfdf3755781d2795795345bb2",
"title": "71040c4058ed04bdfdf3755781d2795795345bb2",
"url": "https://chromium.googlesource.com/chromium/src/+/71040c4058ed04bdfdf3755781d2795795345bb2"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "71040c4058ed04bdfdf3755781d2795795345bb2",
"ref": "refs/branch-heads/8037"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836773294761661200"
},
{
"key": "scheduler_job_id",
"value": "chromium-m154/android-desktop-arm64-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:41:33.103] Scheduled build:
{
"id": "8671343232515160353",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "android-desktop-arm64-official"
},
"number": 30,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-07T05:41:32.615552851Z",
"updateTime": "2026-09-07T05:41:32.615552851Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "71040c4058ed04bdfdf3755781d2795795345bb2",
"ref": "refs/branch-heads/8037"
}
},
"canary": true
}
[05:41:33.103] Task URL: https://cr-buildbucket.appspot.com/build/8671343232515160353
[05:41:33.103] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:2:0) after 3m43s
[05:41:33.189] Received PubSub notification, asking Buildbucket for the build status
[05:41:33.213] Build status: SCHEDULED
[05:42:36.357] Received PubSub notification, asking Buildbucket for the build status
[05:42:36.410] Build status: STARTED
[05:45:16.152] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:2:0)
[05:45:16.177] Build status: STARTED
[05:45:16.177] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:5:0) after 9m54s
[05:55:10.225] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:5:0)
[05:55:10.252] Build status: STARTED
[05:55:10.252] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:6:0) after 3m1s
[05:58:11.266] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:6:0)
[05:58:11.285] Build status: STARTED
[05:58:11.285] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:7:0) after 2m55s
[06:01:06.310] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:7:0)
[06:01:06.328] Build status: STARTED
[06:01:06.328] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:8:0) after 1m43s
[06:02:49.347] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:8:0)
[06:02:49.394] Build status: STARTED
[06:02:49.394] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:9:0) after 6m27s
[06:09:16.411] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:9:0)
[06:09:16.518] Build status: STARTED
[06:09:16.518] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:10:0) after 2m19s
[06:11:35.582] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:10:0)
[06:11:35.793] Build status: STARTED
[06:11:35.793] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:11:0) after 7m8s
[06:18:43.812] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:11:0)
[06:18:43.842] Build status: STARTED
[06:18:43.842] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:12:0) after 8m45s
[06:27:28.859] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:12:0)
[06:27:28.916] Build status: STARTED
[06:27:28.916] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:13:0) after 2m54s
[06:30:22.932] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:13:0)
[06:30:23.189] Build status: STARTED
[06:30:23.189] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:14:0) after 9m18s
[06:39:41.329] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:14:0)
[06:39:41.358] Build status: STARTED
[06:39:41.358] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:15:0) after 9m59s
[06:49:40.608] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:15:0)
[06:49:40.625] Build status: STARTED
[06:49:40.625] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:16:0) after 6m26s
[06:56:06.642] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:16:0)
[06:56:06.696] Build status: STARTED
[06:56:06.696] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:17:0) after 2m48s
[06:58:54.711] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:17:0)
[06:58:54.753] Build status: STARTED
[06:58:54.753] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:18:0) after 1m16s
[07:00:10.768] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:18:0)
[07:00:10.790] Build status: STARTED
[07:00:10.791] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:19:0) after 9m13s
[07:09:23.806] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:19:0)
[07:09:23.829] Build status: STARTED
[07:09:23.829] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:20:0) after 7m46s
[07:17:09.838] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:20:0)
[07:17:09.917] Build status: STARTED
[07:17:09.917] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:21:0) after 2m49s
[07:19:58.932] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:21:0)
[07:19:59.001] Build status: STARTED
[07:19:59.001] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:22:0) after 7m44s
[07:27:43.003] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:22:0)
[07:27:43.032] Build status: STARTED
[07:27:43.032] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:23:0) after 8m46s
[07:36:29.094] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:23:0)
[07:36:29.113] Build status: STARTED
[07:36:29.113] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:24:0) after 2m3s
[07:38:32.127] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:24:0)
[07:38:32.144] Build status: STARTED
[07:38:32.144] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:25:0) after 2m21s
[07:40:53.304] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:25:0)
[07:40:53.333] Build status: STARTED
[07:40:53.333] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:26:0) after 8m13s
[07:49:06.350] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:26:0)
[07:49:06.405] Build status: STARTED
[07:49:06.405] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:27:0) after 6m8s
[07:55:14.547] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:27:0)
[07:55:14.568] Build status: STARTED
[07:55:14.568] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:28:0) after 6m12s
[08:01:26.584] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:28:0)
[08:01:26.652] Build status: STARTED
[08:01:26.652] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:29:0) after 7m39s
[08:09:05.670] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:29:0)
[08:09:05.725] Build status: STARTED
[08:09:05.725] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:30:0) after 4m58s
[08:14:03.746] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:30:0)
[08:14:03.765] Build status: STARTED
[08:14:03.765] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:31:0) after 6m25s
[08:20:28.780] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:31:0)
[08:20:28.818] Build status: STARTED
[08:20:28.818] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:32:0) after 5m0s
[08:25:29.009] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:32:0)
[08:25:29.051] Build status: STARTED
[08:25:29.052] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:33:0) after 7m23s
[08:32:52.445] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:33:0)
[08:32:52.472] Build status: STARTED
[08:32:52.472] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:34:0) after 9m49s
[08:42:41.495] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:34:0)
[08:42:41.514] Build status: STARTED
[08:42:41.514] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:35:0) after 4m31s
[08:47:12.531] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:35:0)
[08:47:12.571] Build status: STARTED
[08:47:12.571] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:36:0) after 9m28s
[08:56:40.646] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:36:0)
[08:56:40.681] Build status: STARTED
[08:56:40.681] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:37:0) after 3m17s
[08:59:57.680] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:37:0)
[08:59:57.738] Build status: STARTED
[08:59:57.738] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:38:0) after 6m32s
[09:06:29.778] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:38:0)
[09:06:29.814] Build status: STARTED
[09:06:29.814] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:39:0) after 7m30s
[09:13:59.831] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:39:0)
[09:13:59.857] Build status: STARTED
[09:13:59.857] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:40:0) after 7m36s
[09:21:35.884] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:40:0)
[09:21:35.932] Build status: STARTED
[09:21:35.932] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:41:0) after 1m10s
[09:22:45.962] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:41:0)
[09:22:45.984] Build status: STARTED
[09:22:45.984] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:42:0) after 4m28s
[09:27:14.000] Handling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:42:0)
[09:27:14.016] Build status: STARTED
[09:27:14.016] Scheduling timer "check-buildbucket-build-status" (chromium-m154/android-desktop-arm64-official:8836773294761661200:43:0) after 4m16s
[09:28:51.815] Received PubSub notification, asking Buildbucket for the build status
[09:28:51.840] Build:
{
"id": "8671343232515160353",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "android-desktop-arm64-official"
},
"number": 30,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-07T05:41:32.615552851Z",
"startTime": "2026-09-07T05:42:33.480469739Z",
"endTime": "2026-09-07T09:28:51.405978411Z",
"updateTime": "2026-09-07T09:28:51.405978411Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "71040c4058ed04bdfdf3755781d2795795345bb2",
"ref": "refs/branch-heads/8037"
}
},
"canary": true
}
[09:28:51.840] Invocation finished in 3h47m20.751079243s with status SUCCEEDED