[06:49:50.625] New invocation is queued and will start shortly
[06:49:51.739] Starting the invocation (attempt 1)
[06:49:51.760] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe"
[06:49:51.760] Popped gitiles commit info from properties and tags
[06:49:51.760] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:49:51.761] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:49:51.761] Buildbucket request:
{
"requestId": "8840936456547827776",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "android-desktop-arm64-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8840936456547827776",
"job": "chromium-m151/android-desktop-arm64-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "518a411a1441a17b98fae1bf358b02c38a9714bb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@518a411a1441a17b98fae1bf358b02c38a9714bb",
"title": "518a411a1441a17b98fae1bf358b02c38a9714bb",
"url": "https://chromium.googlesource.com/chromium/src/+/518a411a1441a17b98fae1bf358b02c38a9714bb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3c882e4ae67ab3984ccaf72f629dddba0a5d7cfb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@3c882e4ae67ab3984ccaf72f629dddba0a5d7cfb",
"title": "3c882e4ae67ab3984ccaf72f629dddba0a5d7cfb",
"url": "https://chromium.googlesource.com/chromium/src/+/3c882e4ae67ab3984ccaf72f629dddba0a5d7cfb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5e191b16f0f0ff5c15293364a8f2bcce2743c5bb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@5e191b16f0f0ff5c15293364a8f2bcce2743c5bb",
"title": "5e191b16f0f0ff5c15293364a8f2bcce2743c5bb",
"url": "https://chromium.googlesource.com/chromium/src/+/5e191b16f0f0ff5c15293364a8f2bcce2743c5bb"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3dbbc600eb9d9b941f9260a540cc7eb953a081a0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@3dbbc600eb9d9b941f9260a540cc7eb953a081a0",
"title": "3dbbc600eb9d9b941f9260a540cc7eb953a081a0",
"url": "https://chromium.googlesource.com/chromium/src/+/3dbbc600eb9d9b941f9260a540cc7eb953a081a0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "26f519696704ece4db1ba807ccede73ad8a3bc22"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@26f519696704ece4db1ba807ccede73ad8a3bc22",
"title": "26f519696704ece4db1ba807ccede73ad8a3bc22",
"url": "https://chromium.googlesource.com/chromium/src/+/26f519696704ece4db1ba807ccede73ad8a3bc22"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "15dca7dbacada6bfccef9bc9ade665ee699ed5e2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@15dca7dbacada6bfccef9bc9ade665ee699ed5e2",
"title": "15dca7dbacada6bfccef9bc9ade665ee699ed5e2",
"url": "https://chromium.googlesource.com/chromium/src/+/15dca7dbacada6bfccef9bc9ade665ee699ed5e2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe",
"title": "9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe",
"url": "https://chromium.googlesource.com/chromium/src/+/9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe",
"ref": "refs/branch-heads/7922"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8840936456547827776"
},
{
"key": "scheduler_job_id",
"value": "chromium-m151/android-desktop-arm64-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:49:52.205] Scheduled build:
{
"id": "8675506394641447473",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "android-desktop-arm64-official"
},
"number": 150,
"createdBy": "project:chromium-m151",
"createTime": "2026-07-23T06:49:51.820417176Z",
"updateTime": "2026-07-23T06:49:51.820417176Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe",
"ref": "refs/branch-heads/7922"
}
},
"canary": true
}
[06:49:52.205] Task URL: https://cr-buildbucket.appspot.com/build/8675506394641447473
[06:49:52.205] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:2:0) after 5m35s
[06:49:53.210] Received PubSub notification, asking Buildbucket for the build status
[06:49:53.235] Build status: SCHEDULED
[06:50:53.387] Received PubSub notification, asking Buildbucket for the build status
[06:50:53.407] Build status: STARTED
[06:55:27.221] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:2:0)
[06:55:27.239] Build status: STARTED
[06:55:27.239] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:5:0) after 9m15s
[07:04:42.253] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:5:0)
[07:04:42.286] Build status: STARTED
[07:04:42.286] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:6:0) after 5m19s
[07:10:01.362] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:6:0)
[07:10:01.385] Build status: STARTED
[07:10:01.386] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:7:0) after 8m18s
[07:18:19.492] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:7:0)
[07:18:19.516] Build status: STARTED
[07:18:19.516] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:8:0) after 5m27s
[07:23:46.508] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:8:0)
[07:23:46.524] Build status: STARTED
[07:23:46.524] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:9:0) after 2m55s
[07:26:41.601] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:9:0)
[07:26:41.621] Build status: STARTED
[07:26:41.621] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:10:0) after 2m35s
[07:29:16.655] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:10:0)
[07:29:16.690] Build status: STARTED
[07:29:16.690] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:11:0) after 5m35s
[07:34:51.738] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:11:0)
[07:34:51.766] Build status: STARTED
[07:34:51.766] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:12:0) after 5m5s
[07:39:56.778] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:12:0)
[07:39:56.798] Build status: STARTED
[07:39:56.798] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:13:0) after 7m43s
[07:47:39.873] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:13:0)
[07:47:39.901] Build status: STARTED
[07:47:39.901] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:14:0) after 1m3s
[07:48:42.956] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:14:0)
[07:48:42.970] Build status: STARTED
[07:48:42.971] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:15:0) after 4m31s
[07:53:13.985] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:15:0)
[07:53:14.007] Build status: STARTED
[07:53:14.007] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:16:0) after 6m34s
[07:59:48.144] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:16:0)
[07:59:48.170] Build status: STARTED
[07:59:48.170] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:17:0) after 6m32s
[08:06:20.221] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:17:0)
[08:06:20.296] Build status: STARTED
[08:06:20.296] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:18:0) after 1m44s
[08:08:04.397] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:18:0)
[08:08:04.426] Build status: STARTED
[08:08:04.426] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:19:0) after 7m25s
[08:15:29.418] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:19:0)
[08:15:29.443] Build status: STARTED
[08:15:29.443] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:20:0) after 5m22s
[08:20:51.530] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:20:0)
[08:20:51.650] Build status: STARTED
[08:20:51.650] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:21:0) after 3m30s
[08:24:21.986] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:21:0)
[08:24:22.007] Build status: STARTED
[08:24:22.007] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:22:0) after 2m45s
[08:27:07.110] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:22:0)
[08:27:07.128] Build status: STARTED
[08:27:07.128] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:23:0) after 2m15s
[08:29:22.143] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:23:0)
[08:29:22.168] Build status: STARTED
[08:29:22.168] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:24:0) after 3m55s
[08:33:17.267] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:24:0)
[08:33:17.284] Build status: STARTED
[08:33:17.285] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:25:0) after 1m39s
[08:34:56.300] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:25:0)
[08:34:56.318] Build status: STARTED
[08:34:56.318] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:26:0) after 3m22s
[08:38:18.338] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:26:0)
[08:38:18.365] Build status: STARTED
[08:38:18.365] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:27:0) after 5m38s
[08:43:56.437] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:27:0)
[08:43:56.455] Build status: STARTED
[08:43:56.455] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:28:0) after 7m29s
[08:51:25.432] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:28:0)
[08:51:25.476] Build status: STARTED
[08:51:25.476] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:29:0) after 9m51s
[09:01:16.493] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:29:0)
[09:01:16.508] Build status: STARTED
[09:01:16.508] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:30:0) after 7m43s
[09:08:59.524] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:30:0)
[09:08:59.544] Build status: STARTED
[09:08:59.544] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:31:0) after 8m32s
[09:17:31.585] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:31:0)
[09:17:31.599] Build status: STARTED
[09:17:31.599] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:32:0) after 4m11s
[09:21:42.673] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:32:0)
[09:21:42.696] Build status: STARTED
[09:21:42.696] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:33:0) after 6m23s
[09:28:05.798] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:33:0)
[09:28:05.837] Build status: STARTED
[09:28:05.837] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:34:0) after 5m20s
[09:33:25.853] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:34:0)
[09:33:25.950] Build status: STARTED
[09:33:25.950] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:35:0) after 2m13s
[09:35:38.978] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:35:0)
[09:35:39.009] Build status: STARTED
[09:35:39.009] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:36:0) after 2m37s
[09:38:16.073] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:36:0)
[09:38:16.092] Build status: STARTED
[09:38:16.092] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:37:0) after 8m16s
[09:46:32.133] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:37:0)
[09:46:32.155] Build status: STARTED
[09:46:32.155] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:38:0) after 6m29s
[09:53:01.374] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:38:0)
[09:53:01.446] Build status: STARTED
[09:53:01.446] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:39:0) after 7m45s
[10:00:46.461] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:39:0)
[10:00:46.486] Build status: STARTED
[10:00:46.486] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:40:0) after 8m55s
[10:09:41.606] Handling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:40:0)
[10:09:41.661] Build status: STARTED
[10:09:41.661] Scheduling timer "check-buildbucket-build-status" (chromium-m151/android-desktop-arm64-official:8840936456547827776:41:0) after 7m31s
[10:13:38.143] Received PubSub notification, asking Buildbucket for the build status
[10:13:38.161] Build:
{
"id": "8675506394641447473",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "android-desktop-arm64-official"
},
"number": 150,
"createdBy": "project:chromium-m151",
"createTime": "2026-07-23T06:49:51.820417176Z",
"startTime": "2026-07-23T06:50:53.215961524Z",
"endTime": "2026-07-23T10:13:37.818285152Z",
"updateTime": "2026-07-23T10:13:37.818285152Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9c4c0a4d7a6d2157fd872edcdae4f3d9d61747fe",
"ref": "refs/branch-heads/7922"
}
},
"canary": true
}
[10:13:38.161] Invocation finished in 3h23m47.542980394s with status SUCCEEDED