[02:50:47.653] New invocation is queued and will start shortly
[02:50:49.048] Starting the invocation (attempt 1)
[02:50:49.073] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e19a97ba30a0429246f7971feea33639b7644bb4"
[02:50:49.073] Popped gitiles commit info from properties and tags
[02:50:49.073] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:50:49.073] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:50:49.074] Buildbucket request:
{
"requestId": "8866862228640499312",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8866862228640499312",
"job": "chromium-m142/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0704dce224a49dc24c9f81683c018b5972077967"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@0704dce224a49dc24c9f81683c018b5972077967",
"title": "0704dce224a49dc24c9f81683c018b5972077967",
"url": "https://chromium.googlesource.com/chromium/src/+/0704dce224a49dc24c9f81683c018b5972077967"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "61cc7a25af705f98af68c7f9138b407b1342dfcc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@61cc7a25af705f98af68c7f9138b407b1342dfcc",
"title": "61cc7a25af705f98af68c7f9138b407b1342dfcc",
"url": "https://chromium.googlesource.com/chromium/src/+/61cc7a25af705f98af68c7f9138b407b1342dfcc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9647626669d0a43c008473c305fe79d28ed2dea6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@9647626669d0a43c008473c305fe79d28ed2dea6",
"title": "9647626669d0a43c008473c305fe79d28ed2dea6",
"url": "https://chromium.googlesource.com/chromium/src/+/9647626669d0a43c008473c305fe79d28ed2dea6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7ca44066e3af8113af475d9856229b69c0184e9e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@7ca44066e3af8113af475d9856229b69c0184e9e",
"title": "7ca44066e3af8113af475d9856229b69c0184e9e",
"url": "https://chromium.googlesource.com/chromium/src/+/7ca44066e3af8113af475d9856229b69c0184e9e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9b588b33462c3d1474c4493ea2028f6700f7c52f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@9b588b33462c3d1474c4493ea2028f6700f7c52f",
"title": "9b588b33462c3d1474c4493ea2028f6700f7c52f",
"url": "https://chromium.googlesource.com/chromium/src/+/9b588b33462c3d1474c4493ea2028f6700f7c52f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "36033f2c67730929f1a92dda34a3c242da0c51a3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@36033f2c67730929f1a92dda34a3c242da0c51a3",
"title": "36033f2c67730929f1a92dda34a3c242da0c51a3",
"url": "https://chromium.googlesource.com/chromium/src/+/36033f2c67730929f1a92dda34a3c242da0c51a3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b21b87196631688662d3f63061bf24c1f8233197"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@b21b87196631688662d3f63061bf24c1f8233197",
"title": "b21b87196631688662d3f63061bf24c1f8233197",
"url": "https://chromium.googlesource.com/chromium/src/+/b21b87196631688662d3f63061bf24c1f8233197"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2ce375282a0afbda3ee601e0d8a8bed1c190c3d8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@2ce375282a0afbda3ee601e0d8a8bed1c190c3d8",
"title": "2ce375282a0afbda3ee601e0d8a8bed1c190c3d8",
"url": "https://chromium.googlesource.com/chromium/src/+/2ce375282a0afbda3ee601e0d8a8bed1c190c3d8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e4b7381cbc1c9e3fe7dbf012ed623241d15fdfbe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@e4b7381cbc1c9e3fe7dbf012ed623241d15fdfbe",
"title": "e4b7381cbc1c9e3fe7dbf012ed623241d15fdfbe",
"url": "https://chromium.googlesource.com/chromium/src/+/e4b7381cbc1c9e3fe7dbf012ed623241d15fdfbe"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "eebeccf4a60946660f545e56b0913c9bcfc74c50"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@eebeccf4a60946660f545e56b0913c9bcfc74c50",
"title": "eebeccf4a60946660f545e56b0913c9bcfc74c50",
"url": "https://chromium.googlesource.com/chromium/src/+/eebeccf4a60946660f545e56b0913c9bcfc74c50"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e19a97ba30a0429246f7971feea33639b7644bb4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@e19a97ba30a0429246f7971feea33639b7644bb4",
"title": "e19a97ba30a0429246f7971feea33639b7644bb4",
"url": "https://chromium.googlesource.com/chromium/src/+/e19a97ba30a0429246f7971feea33639b7644bb4"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e19a97ba30a0429246f7971feea33639b7644bb4",
"ref": "refs/branch-heads/7444"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8866862228640499312"
},
{
"key": "scheduler_job_id",
"value": "chromium-m142/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"
}
}
[02:50:49.568] Scheduled build:
{
"id": "8701432166425946865",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 106,
"createdBy": "project:chromium-m142",
"createTime": "2025-10-10T02:50:49.136606083Z",
"updateTime": "2025-10-10T02:50:49.136606083Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e19a97ba30a0429246f7971feea33639b7644bb4",
"ref": "refs/branch-heads/7444"
}
}
}
[02:50:49.568] Task URL: https://cr-buildbucket.appspot.com/build/8701432166425946865
[02:50:49.568] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:2:0) after 1m35s
[02:50:50.532] Received PubSub notification, asking Buildbucket for the build status
[02:50:50.550] Build status: SCHEDULED
[02:52:24.599] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:2:0)
[02:52:24.624] Build status: SCHEDULED
[02:52:24.624] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:4:0) after 2m56s
[02:55:20.642] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:4:0)
[02:55:20.660] Build status: SCHEDULED
[02:55:20.660] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:5:0) after 4m44s
[03:00:04.716] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:5:0)
[03:00:04.734] Build status: SCHEDULED
[03:00:04.734] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:6:0) after 5m21s
[03:05:25.760] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:6:0)
[03:05:25.782] Build status: SCHEDULED
[03:05:25.782] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:7:0) after 8m17s
[03:13:42.852] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:7:0)
[03:13:42.875] Build status: SCHEDULED
[03:13:42.875] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:8:0) after 4m57s
[03:18:39.892] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:8:0)
[03:18:39.910] Build status: SCHEDULED
[03:18:39.910] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:9:0) after 9m49s
[03:28:28.951] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:9:0)
[03:28:29.056] Build status: SCHEDULED
[03:28:29.056] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:10:0) after 2m5s
[03:30:34.124] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:10:0)
[03:30:34.192] Build status: SCHEDULED
[03:30:34.192] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:11:0) after 8m1s
[03:38:35.368] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:11:0)
[03:38:35.387] Build status: SCHEDULED
[03:38:35.387] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:12:0) after 6m17s
[03:39:46.882] Received PubSub notification, asking Buildbucket for the build status
[03:39:46.905] Build status: STARTED
[03:44:52.450] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:12:0)
[03:44:52.472] Build status: STARTED
[03:44:52.473] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:14:0) after 7m6s
[03:51:58.565] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:14:0)
[03:51:58.589] Build status: STARTED
[03:51:58.589] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:15:0) after 1m45s
[03:53:43.636] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:15:0)
[03:53:43.685] Build status: STARTED
[03:53:43.685] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:16:0) after 2m31s
[03:56:14.702] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:16:0)
[03:56:14.718] Build status: STARTED
[03:56:14.718] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:17:0) after 7m28s
[04:03:42.740] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:17:0)
[04:03:42.763] Build status: STARTED
[04:03:42.764] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:18:0) after 2m7s
[04:05:49.731] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:18:0)
[04:05:49.748] Build status: STARTED
[04:05:49.748] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:19:0) after 6m34s
[04:12:23.802] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:19:0)
[04:12:23.819] Build status: STARTED
[04:12:23.819] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:20:0) after 6m58s
[04:19:21.877] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:20:0)
[04:19:21.904] Build status: STARTED
[04:19:21.904] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:21:0) after 2m33s
[04:21:54.918] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:21:0)
[04:21:54.942] Build status: STARTED
[04:21:54.942] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:22:0) after 5m58s
[04:27:53.035] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:22:0)
[04:27:53.059] Build status: STARTED
[04:27:53.059] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:23:0) after 4m26s
[04:32:19.079] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:23:0)
[04:32:19.096] Build status: STARTED
[04:32:19.096] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:24:0) after 4m20s
[04:36:39.163] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:24:0)
[04:36:39.188] Build status: STARTED
[04:36:39.188] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:25:0) after 4m42s
[04:41:21.206] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:25:0)
[04:41:21.243] Build status: STARTED
[04:41:21.243] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:26:0) after 8m8s
[04:49:29.260] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:26:0)
[04:49:29.275] Build status: STARTED
[04:49:29.275] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:27:0) after 6m8s
[04:55:37.274] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:27:0)
[04:55:37.295] Build status: STARTED
[04:55:37.295] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:28:0) after 7m13s
[05:02:50.325] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:28:0)
[05:02:50.340] Build status: STARTED
[05:02:50.340] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:29:0) after 1m46s
[05:04:36.415] Handling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:29:0)
[05:04:36.428] Build status: STARTED
[05:04:36.428] Scheduling timer "check-buildbucket-build-status" (chromium-m142/Android x64 Builder All Targets (dbg):8866862228640499312:30:0) after 9m37s
[05:10:17.945] Received PubSub notification, asking Buildbucket for the build status
[05:10:17.986] Build:
{
"id": "8701432166425946865",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 106,
"createdBy": "project:chromium-m142",
"createTime": "2025-10-10T02:50:49.136606083Z",
"startTime": "2025-10-10T03:39:46.710110617Z",
"endTime": "2025-10-10T05:10:17.688201912Z",
"updateTime": "2025-10-10T05:10:17.688201912Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e19a97ba30a0429246f7971feea33639b7644bb4",
"ref": "refs/branch-heads/7444"
}
}
}
[05:10:17.986] Invocation finished in 2h19m30.346216961s with status SUCCEEDED