[08:17:55.822] New invocation is queued and will start shortly
[08:17:56.926] Starting the invocation (attempt 1)
[08:17:56.954] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/44dea659bdc1e82f06982f277d253da87fb7ee92"
[08:17:56.954] Popped gitiles commit info from properties and tags
[08:17:56.954] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:17:56.954] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:17:56.955] Buildbucket request:
{
"requestId": "8885323428158044336",
"builder": {
"project": "chromium-m135",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8885323428158044336",
"job": "chromium-m135/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e43d6245c249ff089f6b8e18fbdba312e04eba93"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@e43d6245c249ff089f6b8e18fbdba312e04eba93",
"title": "e43d6245c249ff089f6b8e18fbdba312e04eba93",
"url": "https://chromium.googlesource.com/chromium/src/+/e43d6245c249ff089f6b8e18fbdba312e04eba93"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "837a8089b03e0811afac62d9b675765602b78a33"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@837a8089b03e0811afac62d9b675765602b78a33",
"title": "837a8089b03e0811afac62d9b675765602b78a33",
"url": "https://chromium.googlesource.com/chromium/src/+/837a8089b03e0811afac62d9b675765602b78a33"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "159de51d745d400de2e414da48cbb15d2a0d92ca"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@159de51d745d400de2e414da48cbb15d2a0d92ca",
"title": "159de51d745d400de2e414da48cbb15d2a0d92ca",
"url": "https://chromium.googlesource.com/chromium/src/+/159de51d745d400de2e414da48cbb15d2a0d92ca"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ffe4c47a3d773dbdb04c539bff1b161443d8e582"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@ffe4c47a3d773dbdb04c539bff1b161443d8e582",
"title": "ffe4c47a3d773dbdb04c539bff1b161443d8e582",
"url": "https://chromium.googlesource.com/chromium/src/+/ffe4c47a3d773dbdb04c539bff1b161443d8e582"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7c7dc86b6617cda6e9996ff0d2640be4558bdc03"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@7c7dc86b6617cda6e9996ff0d2640be4558bdc03",
"title": "7c7dc86b6617cda6e9996ff0d2640be4558bdc03",
"url": "https://chromium.googlesource.com/chromium/src/+/7c7dc86b6617cda6e9996ff0d2640be4558bdc03"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "df342cdb51c5a519fb48e410ecc8e78249356e40"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@df342cdb51c5a519fb48e410ecc8e78249356e40",
"title": "df342cdb51c5a519fb48e410ecc8e78249356e40",
"url": "https://chromium.googlesource.com/chromium/src/+/df342cdb51c5a519fb48e410ecc8e78249356e40"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0fadbaaef7ce59998dcaecab98db1a6758de1a76"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@0fadbaaef7ce59998dcaecab98db1a6758de1a76",
"title": "0fadbaaef7ce59998dcaecab98db1a6758de1a76",
"url": "https://chromium.googlesource.com/chromium/src/+/0fadbaaef7ce59998dcaecab98db1a6758de1a76"
},
{
"gitiles": {
"ref": "refs/branch-heads/7049",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "44dea659bdc1e82f06982f277d253da87fb7ee92"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7049@44dea659bdc1e82f06982f277d253da87fb7ee92",
"title": "44dea659bdc1e82f06982f277d253da87fb7ee92",
"url": "https://chromium.googlesource.com/chromium/src/+/44dea659bdc1e82f06982f277d253da87fb7ee92"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "44dea659bdc1e82f06982f277d253da87fb7ee92",
"ref": "refs/branch-heads/7049"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8885323428158044336"
},
{
"key": "scheduler_job_id",
"value": "chromium-m135/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"
}
}
[08:17:57.589] Scheduled build:
{
"id": "8719893366252838721",
"builder": {
"project": "chromium-m135",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 92,
"createdBy": "project:chromium-m135",
"createTime": "2025-03-20T08:17:57.011078607Z",
"updateTime": "2025-03-20T08:17:57.011078607Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "44dea659bdc1e82f06982f277d253da87fb7ee92",
"ref": "refs/branch-heads/7049"
}
},
"canary": true
}
[08:17:57.589] Task URL: https://cr-buildbucket.appspot.com/build/8719893366252838721
[08:17:57.589] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:2:0) after 6m36s
[08:17:58.479] Received PubSub notification, asking Buildbucket for the build status
[08:17:58.508] Build status: SCHEDULED
[08:24:33.736] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:2:0)
[08:24:33.764] Build status: SCHEDULED
[08:24:33.764] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:4:0) after 9m19s
[08:33:52.789] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:4:0)
[08:33:52.823] Build status: SCHEDULED
[08:33:52.823] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:5:0) after 8m18s
[08:42:10.851] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:5:0)
[08:42:10.876] Build status: SCHEDULED
[08:42:10.876] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:6:0) after 3m44s
[08:42:31.514] Received PubSub notification, asking Buildbucket for the build status
[08:42:31.539] Build status: STARTED
[08:45:55.193] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:6:0)
[08:45:55.250] Build status: STARTED
[08:45:55.250] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:8:0) after 6m23s
[08:52:18.335] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:8:0)
[08:52:18.353] Build status: STARTED
[08:52:18.353] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:9:0) after 8m28s
[09:00:46.396] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:9:0)
[09:00:46.421] Build status: STARTED
[09:00:46.421] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:10:0) after 8m4s
[09:08:50.442] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:10:0)
[09:08:50.469] Build status: STARTED
[09:08:50.469] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:11:0) after 9m0s
[09:17:50.763] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:11:0)
[09:17:50.785] Build status: STARTED
[09:17:50.785] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:12:0) after 4m45s
[09:22:35.910] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:12:0)
[09:22:35.926] Build status: STARTED
[09:22:35.926] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:13:0) after 6m51s
[09:29:27.155] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:13:0)
[09:29:27.174] Build status: STARTED
[09:29:27.174] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:14:0) after 9m58s
[09:39:25.192] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:14:0)
[09:39:25.218] Build status: STARTED
[09:39:25.218] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:15:0) after 9m55s
[09:49:20.322] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:15:0)
[09:49:20.344] Build status: STARTED
[09:49:20.344] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:16:0) after 6m31s
[09:55:51.958] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:16:0)
[09:55:52.039] Build status: STARTED
[09:55:52.039] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:17:0) after 4m39s
[10:00:31.290] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:17:0)
[10:00:31.317] Build status: STARTED
[10:00:31.317] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:18:0) after 6m29s
[10:07:00.342] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:18:0)
[10:07:00.359] Build status: STARTED
[10:07:00.359] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:19:0) after 6m2s
[10:13:02.537] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:19:0)
[10:13:02.553] Build status: STARTED
[10:13:02.553] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:20:0) after 5m36s
[10:18:38.727] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:20:0)
[10:18:38.754] Build status: STARTED
[10:18:38.754] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:21:0) after 3m21s
[10:21:59.870] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:21:0)
[10:21:59.886] Build status: STARTED
[10:21:59.886] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:22:0) after 2m37s
[10:24:36.902] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:22:0)
[10:24:36.927] Build status: STARTED
[10:24:36.927] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:23:0) after 5m38s
[10:30:14.954] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:23:0)
[10:30:14.972] Build status: STARTED
[10:30:14.972] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:24:0) after 2m27s
[10:32:42.080] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:24:0)
[10:32:42.107] Build status: STARTED
[10:32:42.107] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:25:0) after 3m1s
[10:35:43.126] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:25:0)
[10:35:43.148] Build status: STARTED
[10:35:43.148] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:26:0) after 3m59s
[10:39:42.335] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:26:0)
[10:39:42.358] Build status: STARTED
[10:39:42.358] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:27:0) after 3m37s
[10:43:19.378] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:27:0)
[10:43:19.399] Build status: STARTED
[10:43:19.399] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:28:0) after 3m11s
[10:46:30.586] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:28:0)
[10:46:30.601] Build status: STARTED
[10:46:30.601] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:29:0) after 1m16s
[10:47:46.736] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:29:0)
[10:47:46.757] Build status: STARTED
[10:47:46.757] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:30:0) after 4m31s
[10:52:17.832] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:30:0)
[10:52:17.856] Build status: STARTED
[10:52:17.856] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:31:0) after 8m23s
[11:00:40.888] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:31:0)
[11:00:40.924] Build status: STARTED
[11:00:40.924] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:32:0) after 4m57s
[11:05:37.950] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:32:0)
[11:05:37.966] Build status: STARTED
[11:05:37.966] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:33:0) after 3m1s
[11:08:38.980] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:33:0)
[11:08:38.996] Build status: STARTED
[11:08:38.996] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:34:0) after 6m57s
[11:15:36.096] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:34:0)
[11:15:36.113] Build status: STARTED
[11:15:36.113] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:35:0) after 4m2s
[11:19:38.134] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:35:0)
[11:19:38.152] Build status: STARTED
[11:19:38.152] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:36:0) after 4m21s
[11:23:59.185] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:36:0)
[11:23:59.200] Build status: STARTED
[11:23:59.200] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:37:0) after 2m37s
[11:26:36.770] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:37:0)
[11:26:36.788] Build status: STARTED
[11:26:36.788] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:38:0) after 6m23s
[11:32:59.821] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:38:0)
[11:32:59.841] Build status: STARTED
[11:32:59.841] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:39:0) after 7m0s
[11:40:00.034] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:39:0)
[11:40:00.049] Build status: STARTED
[11:40:00.049] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:40:0) after 5m18s
[11:45:18.099] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:40:0)
[11:45:18.124] Build status: STARTED
[11:45:18.124] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:41:0) after 3m49s
[11:49:07.138] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:41:0)
[11:49:07.158] Build status: STARTED
[11:49:07.158] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:42:0) after 4m14s
[11:53:21.157] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:42:0)
[11:53:21.172] Build status: STARTED
[11:53:21.172] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:43:0) after 9m34s
[12:02:55.179] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:43:0)
[12:02:55.200] Build status: STARTED
[12:02:55.200] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:44:0) after 4m4s
[12:06:59.217] Handling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:44:0)
[12:06:59.242] Build status: STARTED
[12:06:59.242] Scheduling timer "check-buildbucket-build-status" (chromium-m135/Android x64 Builder All Targets (dbg):8885323428158044336:45:0) after 9m9s
[12:14:42.095] Received PubSub notification, asking Buildbucket for the build status
[12:14:42.172] Build:
{
"id": "8719893366252838721",
"builder": {
"project": "chromium-m135",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 92,
"createdBy": "project:chromium-m135",
"createTime": "2025-03-20T08:17:57.011078607Z",
"startTime": "2025-03-20T08:42:30.102877987Z",
"endTime": "2025-03-20T12:14:40.954759805Z",
"updateTime": "2025-03-20T12:14:40.954759805Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "44dea659bdc1e82f06982f277d253da87fb7ee92",
"ref": "refs/branch-heads/7049"
}
},
"canary": true
}
[12:14:42.172] Invocation finished in 3h56m46.36229856s with status SUCCEEDED