[19:08:37.261] New invocation is queued and will start shortly
[19:08:38.562] Starting the invocation (attempt 1)
[19:08:38.587] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97ab403f402142e12b9f7c69885466cbd47a86ff"
[19:08:38.587] Popped gitiles commit info from properties and tags
[19:08:38.587] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:08:38.587] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:08:38.588] Buildbucket request:
{
"requestId": "8860277727519465440",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8860277727519465440",
"job": "chromium-m144/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1e51a6003bbd4bc721ee3b634904e395c7bbade1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@1e51a6003bbd4bc721ee3b634904e395c7bbade1",
"title": "1e51a6003bbd4bc721ee3b634904e395c7bbade1",
"url": "https://chromium.googlesource.com/chromium/src/+/1e51a6003bbd4bc721ee3b634904e395c7bbade1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4d232c9764273e8259355b46d88d94946274e0a6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@4d232c9764273e8259355b46d88d94946274e0a6",
"title": "4d232c9764273e8259355b46d88d94946274e0a6",
"url": "https://chromium.googlesource.com/chromium/src/+/4d232c9764273e8259355b46d88d94946274e0a6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0a36f2dbd366f86708b1d7452608a1e9e6ef9344"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@0a36f2dbd366f86708b1d7452608a1e9e6ef9344",
"title": "0a36f2dbd366f86708b1d7452608a1e9e6ef9344",
"url": "https://chromium.googlesource.com/chromium/src/+/0a36f2dbd366f86708b1d7452608a1e9e6ef9344"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d33955d935bf8732910ee9144bb75680f7a41612"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@d33955d935bf8732910ee9144bb75680f7a41612",
"title": "d33955d935bf8732910ee9144bb75680f7a41612",
"url": "https://chromium.googlesource.com/chromium/src/+/d33955d935bf8732910ee9144bb75680f7a41612"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ef25663e745ec556f8cc4675dac72fd3e06fe198"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@ef25663e745ec556f8cc4675dac72fd3e06fe198",
"title": "ef25663e745ec556f8cc4675dac72fd3e06fe198",
"url": "https://chromium.googlesource.com/chromium/src/+/ef25663e745ec556f8cc4675dac72fd3e06fe198"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f7b9e7d9d113bcb87518ff0647d94ce4d4687416"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@f7b9e7d9d113bcb87518ff0647d94ce4d4687416",
"title": "f7b9e7d9d113bcb87518ff0647d94ce4d4687416",
"url": "https://chromium.googlesource.com/chromium/src/+/f7b9e7d9d113bcb87518ff0647d94ce4d4687416"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "430bf16d4fbc6aa6f08ccff75151a1eb88184791"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@430bf16d4fbc6aa6f08ccff75151a1eb88184791",
"title": "430bf16d4fbc6aa6f08ccff75151a1eb88184791",
"url": "https://chromium.googlesource.com/chromium/src/+/430bf16d4fbc6aa6f08ccff75151a1eb88184791"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0756d3f1d551cccb24b9d7141f5397681c66dde6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@0756d3f1d551cccb24b9d7141f5397681c66dde6",
"title": "0756d3f1d551cccb24b9d7141f5397681c66dde6",
"url": "https://chromium.googlesource.com/chromium/src/+/0756d3f1d551cccb24b9d7141f5397681c66dde6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d7f13463ce8df41f6242ec8c609159b2a0649659"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@d7f13463ce8df41f6242ec8c609159b2a0649659",
"title": "d7f13463ce8df41f6242ec8c609159b2a0649659",
"url": "https://chromium.googlesource.com/chromium/src/+/d7f13463ce8df41f6242ec8c609159b2a0649659"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2758ed4ef6b94924740d29490c92d5271aca3c5b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@2758ed4ef6b94924740d29490c92d5271aca3c5b",
"title": "2758ed4ef6b94924740d29490c92d5271aca3c5b",
"url": "https://chromium.googlesource.com/chromium/src/+/2758ed4ef6b94924740d29490c92d5271aca3c5b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e34ac5fa39d83cc2989d29f3170aca48fa0e0203"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@e34ac5fa39d83cc2989d29f3170aca48fa0e0203",
"title": "e34ac5fa39d83cc2989d29f3170aca48fa0e0203",
"url": "https://chromium.googlesource.com/chromium/src/+/e34ac5fa39d83cc2989d29f3170aca48fa0e0203"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "45879db1057d14b8e028b6b151b4378ab3c1c052"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@45879db1057d14b8e028b6b151b4378ab3c1c052",
"title": "45879db1057d14b8e028b6b151b4378ab3c1c052",
"url": "https://chromium.googlesource.com/chromium/src/+/45879db1057d14b8e028b6b151b4378ab3c1c052"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "17bfa5f8db11b92dd68ced94e72e8725375134d6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@17bfa5f8db11b92dd68ced94e72e8725375134d6",
"title": "17bfa5f8db11b92dd68ced94e72e8725375134d6",
"url": "https://chromium.googlesource.com/chromium/src/+/17bfa5f8db11b92dd68ced94e72e8725375134d6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2dd89d3662f246c0b0db05862451c55f2ef77ac8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@2dd89d3662f246c0b0db05862451c55f2ef77ac8",
"title": "2dd89d3662f246c0b0db05862451c55f2ef77ac8",
"url": "https://chromium.googlesource.com/chromium/src/+/2dd89d3662f246c0b0db05862451c55f2ef77ac8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "baae65c48b3c6f4241d657a74d7686d8a86cf851"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@baae65c48b3c6f4241d657a74d7686d8a86cf851",
"title": "baae65c48b3c6f4241d657a74d7686d8a86cf851",
"url": "https://chromium.googlesource.com/chromium/src/+/baae65c48b3c6f4241d657a74d7686d8a86cf851"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c996e35f0183324ffe26653e0c4fa7428c276769"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@c996e35f0183324ffe26653e0c4fa7428c276769",
"title": "c996e35f0183324ffe26653e0c4fa7428c276769",
"url": "https://chromium.googlesource.com/chromium/src/+/c996e35f0183324ffe26653e0c4fa7428c276769"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f42fe0d67eea2b822b0337c9c9473d940c8e8adc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@f42fe0d67eea2b822b0337c9c9473d940c8e8adc",
"title": "f42fe0d67eea2b822b0337c9c9473d940c8e8adc",
"url": "https://chromium.googlesource.com/chromium/src/+/f42fe0d67eea2b822b0337c9c9473d940c8e8adc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "97ab403f402142e12b9f7c69885466cbd47a86ff"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@97ab403f402142e12b9f7c69885466cbd47a86ff",
"title": "97ab403f402142e12b9f7c69885466cbd47a86ff",
"url": "https://chromium.googlesource.com/chromium/src/+/97ab403f402142e12b9f7c69885466cbd47a86ff"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "97ab403f402142e12b9f7c69885466cbd47a86ff",
"ref": "refs/branch-heads/7559"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8860277727519465440"
},
{
"key": "scheduler_job_id",
"value": "chromium-m144/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"
}
}
[19:08:39.027] Scheduled build:
{
"id": "8694847665400987713",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 311,
"createdBy": "project:chromium-m144",
"createTime": "2025-12-21T19:08:38.650381247Z",
"updateTime": "2025-12-21T19:08:38.650381247Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "97ab403f402142e12b9f7c69885466cbd47a86ff",
"ref": "refs/branch-heads/7559"
}
}
}
[19:08:39.027] Task URL: https://cr-buildbucket.appspot.com/build/8694847665400987713
[19:08:39.027] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:2:0) after 3m16s
[19:08:40.018] Received PubSub notification, asking Buildbucket for the build status
[19:08:40.036] Build status: SCHEDULED
[19:11:55.030] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:2:0)
[19:11:55.049] Build status: SCHEDULED
[19:11:55.049] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:4:0) after 8m11s
[19:20:06.122] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:4:0)
[19:20:06.142] Build status: SCHEDULED
[19:20:06.142] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:5:0) after 4m31s
[19:24:37.172] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:5:0)
[19:24:37.192] Build status: SCHEDULED
[19:24:37.192] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:6:0) after 9m49s
[19:34:26.205] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:6:0)
[19:34:26.224] Build status: SCHEDULED
[19:34:26.225] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:7:0) after 4m45s
[19:39:11.238] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:7:0)
[19:39:11.254] Build status: SCHEDULED
[19:39:11.254] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:8:0) after 9m51s
[19:49:02.377] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:8:0)
[19:49:02.399] Build status: SCHEDULED
[19:49:02.399] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:9:0) after 9m58s
[19:53:25.431] Received PubSub notification, asking Buildbucket for the build status
[19:53:25.451] Build status: STARTED
[19:59:00.416] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:9:0)
[19:59:00.435] Build status: STARTED
[19:59:00.435] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:11:0) after 2m4s
[20:01:04.421] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:11:0)
[20:01:04.436] Build status: STARTED
[20:01:04.437] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:12:0) after 3m52s
[20:04:56.460] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:12:0)
[20:04:56.504] Build status: STARTED
[20:04:56.504] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:13:0) after 3m44s
[20:08:40.518] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:13:0)
[20:08:40.564] Build status: STARTED
[20:08:40.564] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:14:0) after 1m2s
[20:09:42.754] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:14:0)
[20:09:42.782] Build status: STARTED
[20:09:42.782] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:15:0) after 3m38s
[20:13:20.794] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:15:0)
[20:13:20.971] Build status: STARTED
[20:13:20.971] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:16:0) after 1m20s
[20:14:40.985] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:16:0)
[20:14:41.064] Build status: STARTED
[20:14:41.064] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:17:0) after 7m46s
[20:22:27.081] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:17:0)
[20:22:27.101] Build status: STARTED
[20:22:27.101] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:18:0) after 2m27s
[20:24:54.119] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:18:0)
[20:24:54.138] Build status: STARTED
[20:24:54.138] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:19:0) after 6m41s
[20:31:35.327] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:19:0)
[20:31:35.371] Build status: STARTED
[20:31:35.371] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:20:0) after 9m8s
[20:40:43.494] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:20:0)
[20:40:43.513] Build status: STARTED
[20:40:43.513] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:21:0) after 4m47s
[20:45:30.568] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:21:0)
[20:45:30.587] Build status: STARTED
[20:45:30.587] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:22:0) after 9m57s
[20:55:27.601] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:22:0)
[20:55:27.614] Build status: STARTED
[20:55:27.615] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:23:0) after 6m56s
[21:02:23.739] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:23:0)
[21:02:23.754] Build status: STARTED
[21:02:23.754] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:24:0) after 4m51s
[21:07:14.785] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:24:0)
[21:07:14.799] Build status: STARTED
[21:07:14.799] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:25:0) after 5m57s
[21:13:11.897] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:25:0)
[21:13:11.917] Build status: STARTED
[21:13:11.917] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:26:0) after 4m30s
[21:17:41.892] Handling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:26:0)
[21:17:41.922] Build status: STARTED
[21:17:41.922] Scheduling timer "check-buildbucket-build-status" (chromium-m144/Android x64 Builder All Targets (dbg):8860277727519465440:27:0) after 6m24s
[21:21:15.240] Received PubSub notification, asking Buildbucket for the build status
[21:21:15.257] Build:
{
"id": "8694847665400987713",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 311,
"createdBy": "project:chromium-m144",
"createTime": "2025-12-21T19:08:38.650381247Z",
"startTime": "2025-12-21T19:53:25.250208980Z",
"endTime": "2025-12-21T21:21:14.978176104Z",
"updateTime": "2025-12-21T21:21:14.978176104Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "97ab403f402142e12b9f7c69885466cbd47a86ff",
"ref": "refs/branch-heads/7559"
}
}
}
[21:21:15.257] Invocation finished in 2h12m38.011394923s with status SUCCEEDED