[19:53:56.529] New invocation is queued and will start shortly
[19:53:57.707] Starting the invocation (attempt 1)
[19:53:57.745] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3163520ce9ce61d59e45d4a15dd4344ab01b1f6b"
[19:53:57.745] Popped gitiles commit info from properties and tags
[19:53:57.745] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:53:57.745] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:53:57.746] Buildbucket request:
{
"requestId": "8896332468780218032",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "android-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896332468780218032",
"job": "chromium-m132/android-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f026a49c7e1f10af068b3d8f76d444f9faf605ef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@f026a49c7e1f10af068b3d8f76d444f9faf605ef",
"title": "f026a49c7e1f10af068b3d8f76d444f9faf605ef",
"url": "https://chromium.googlesource.com/chromium/src/+/f026a49c7e1f10af068b3d8f76d444f9faf605ef"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bb985673b0d953cd9bbae491634485f769ddf109"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@bb985673b0d953cd9bbae491634485f769ddf109",
"title": "bb985673b0d953cd9bbae491634485f769ddf109",
"url": "https://chromium.googlesource.com/chromium/src/+/bb985673b0d953cd9bbae491634485f769ddf109"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8e4821ba1a3e08e8c51b840f4be6a9f77ce323c9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@8e4821ba1a3e08e8c51b840f4be6a9f77ce323c9",
"title": "8e4821ba1a3e08e8c51b840f4be6a9f77ce323c9",
"url": "https://chromium.googlesource.com/chromium/src/+/8e4821ba1a3e08e8c51b840f4be6a9f77ce323c9"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "608c40bc8196fbf831aac0f782e3ecceeaf8e6d4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@608c40bc8196fbf831aac0f782e3ecceeaf8e6d4",
"title": "608c40bc8196fbf831aac0f782e3ecceeaf8e6d4",
"url": "https://chromium.googlesource.com/chromium/src/+/608c40bc8196fbf831aac0f782e3ecceeaf8e6d4"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2432b1260ecda89f906ba6fac84a69530991b756"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@2432b1260ecda89f906ba6fac84a69530991b756",
"title": "2432b1260ecda89f906ba6fac84a69530991b756",
"url": "https://chromium.googlesource.com/chromium/src/+/2432b1260ecda89f906ba6fac84a69530991b756"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "da9a0a1a99954b35eda8c2ea60d796315fa33dd6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@da9a0a1a99954b35eda8c2ea60d796315fa33dd6",
"title": "da9a0a1a99954b35eda8c2ea60d796315fa33dd6",
"url": "https://chromium.googlesource.com/chromium/src/+/da9a0a1a99954b35eda8c2ea60d796315fa33dd6"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0de306928f401e5aed35d63591a7e1a5d0a64769"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@0de306928f401e5aed35d63591a7e1a5d0a64769",
"title": "0de306928f401e5aed35d63591a7e1a5d0a64769",
"url": "https://chromium.googlesource.com/chromium/src/+/0de306928f401e5aed35d63591a7e1a5d0a64769"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "660f162ccc7039269e3b1d5d40a073efe38f5270"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@660f162ccc7039269e3b1d5d40a073efe38f5270",
"title": "660f162ccc7039269e3b1d5d40a073efe38f5270",
"url": "https://chromium.googlesource.com/chromium/src/+/660f162ccc7039269e3b1d5d40a073efe38f5270"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ff3c1630cf179b2d6a2e2e58bf95aaf2617698d5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@ff3c1630cf179b2d6a2e2e58bf95aaf2617698d5",
"title": "ff3c1630cf179b2d6a2e2e58bf95aaf2617698d5",
"url": "https://chromium.googlesource.com/chromium/src/+/ff3c1630cf179b2d6a2e2e58bf95aaf2617698d5"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "892518bcc590382a03270e26a6a51cc35a8c26a9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@892518bcc590382a03270e26a6a51cc35a8c26a9",
"title": "892518bcc590382a03270e26a6a51cc35a8c26a9",
"url": "https://chromium.googlesource.com/chromium/src/+/892518bcc590382a03270e26a6a51cc35a8c26a9"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4c7b563e96ef99daae9aa1d344ab7ddd0a64d284"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@4c7b563e96ef99daae9aa1d344ab7ddd0a64d284",
"title": "4c7b563e96ef99daae9aa1d344ab7ddd0a64d284",
"url": "https://chromium.googlesource.com/chromium/src/+/4c7b563e96ef99daae9aa1d344ab7ddd0a64d284"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "814853ff3ea679ba04ee67bf21adeaa15d0f9f26"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@814853ff3ea679ba04ee67bf21adeaa15d0f9f26",
"title": "814853ff3ea679ba04ee67bf21adeaa15d0f9f26",
"url": "https://chromium.googlesource.com/chromium/src/+/814853ff3ea679ba04ee67bf21adeaa15d0f9f26"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "594b3d9adef481d541cf3467a78acdff08484a24"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@594b3d9adef481d541cf3467a78acdff08484a24",
"title": "594b3d9adef481d541cf3467a78acdff08484a24",
"url": "https://chromium.googlesource.com/chromium/src/+/594b3d9adef481d541cf3467a78acdff08484a24"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8334c6c42272a99393d190e51765f45845e3ce4a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@8334c6c42272a99393d190e51765f45845e3ce4a",
"title": "8334c6c42272a99393d190e51765f45845e3ce4a",
"url": "https://chromium.googlesource.com/chromium/src/+/8334c6c42272a99393d190e51765f45845e3ce4a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "681d4192d25c001cc8511aec5a837c94679b7c2a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@681d4192d25c001cc8511aec5a837c94679b7c2a",
"title": "681d4192d25c001cc8511aec5a837c94679b7c2a",
"url": "https://chromium.googlesource.com/chromium/src/+/681d4192d25c001cc8511aec5a837c94679b7c2a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b41943dd61938f315d7d7ef5d3155414368cb54e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@b41943dd61938f315d7d7ef5d3155414368cb54e",
"title": "b41943dd61938f315d7d7ef5d3155414368cb54e",
"url": "https://chromium.googlesource.com/chromium/src/+/b41943dd61938f315d7d7ef5d3155414368cb54e"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3163520ce9ce61d59e45d4a15dd4344ab01b1f6b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@3163520ce9ce61d59e45d4a15dd4344ab01b1f6b",
"title": "3163520ce9ce61d59e45d4a15dd4344ab01b1f6b",
"url": "https://chromium.googlesource.com/chromium/src/+/3163520ce9ce61d59e45d4a15dd4344ab01b1f6b"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3163520ce9ce61d59e45d4a15dd4344ab01b1f6b",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896332468780218032"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/android-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:53:58.273] Scheduled build:
{
"id": "8730902406770501153",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "android-official"
},
"number": 86,
"createdBy": "project:chromium-m132",
"createTime": "2024-11-18T19:53:57.821838043Z",
"updateTime": "2024-11-18T19:53:57.821838043Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3163520ce9ce61d59e45d4a15dd4344ab01b1f6b",
"ref": "refs/branch-heads/6834"
}
}
}
[19:53:58.273] Task URL: https://cr-buildbucket.appspot.com/build/8730902406770501153
[19:53:58.273] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:2:0) after 3m7s
[19:53:59.261] Received PubSub notification, asking Buildbucket for the build status
[19:53:59.292] Build status: SCHEDULED
[19:55:06.978] Received PubSub notification, asking Buildbucket for the build status
[19:55:06.999] Build status: STARTED
[19:57:05.338] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:2:0)
[19:57:05.408] Build status: STARTED
[19:57:05.408] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:5:0) after 6m58s
[20:04:03.482] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:5:0)
[20:04:03.505] Build status: STARTED
[20:04:03.506] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:6:0) after 1m50s
[20:05:53.525] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:6:0)
[20:05:53.545] Build status: STARTED
[20:05:53.545] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:7:0) after 5m12s
[20:11:05.613] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:7:0)
[20:11:05.636] Build status: STARTED
[20:11:05.636] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:8:0) after 2m6s
[20:13:11.658] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:8:0)
[20:13:11.680] Build status: STARTED
[20:13:11.680] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:9:0) after 2m8s
[20:15:19.697] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:9:0)
[20:15:19.714] Build status: STARTED
[20:15:19.714] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:10:0) after 5m13s
[20:20:32.732] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:10:0)
[20:20:32.758] Build status: STARTED
[20:20:32.758] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:11:0) after 3m10s
[20:23:42.824] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:11:0)
[20:23:42.842] Build status: STARTED
[20:23:42.842] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:12:0) after 7m11s
[20:30:53.883] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:12:0)
[20:30:53.905] Build status: STARTED
[20:30:53.905] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:13:0) after 7m45s
[20:38:38.973] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:13:0)
[20:38:38.990] Build status: STARTED
[20:38:38.990] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:14:0) after 1m25s
[20:40:04.027] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:14:0)
[20:40:04.363] Build status: STARTED
[20:40:04.363] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:15:0) after 3m33s
[20:43:37.360] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:15:0)
[20:43:37.379] Build status: STARTED
[20:43:37.379] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:16:0) after 4m2s
[20:47:39.503] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:16:0)
[20:47:39.532] Build status: STARTED
[20:47:39.532] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:17:0) after 1m32s
[20:49:11.601] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:17:0)
[20:49:11.624] Build status: STARTED
[20:49:11.624] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:18:0) after 4m36s
[20:53:47.636] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:18:0)
[20:53:47.652] Build status: STARTED
[20:53:47.652] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:19:0) after 1m55s
[20:55:42.723] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:19:0)
[20:55:42.862] Build status: STARTED
[20:55:42.862] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:20:0) after 8m21s
[21:04:03.876] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:20:0)
[21:04:03.897] Build status: STARTED
[21:04:03.897] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:21:0) after 5m18s
[21:09:21.988] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:21:0)
[21:09:22.004] Build status: STARTED
[21:09:22.004] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:22:0) after 1m21s
[21:10:43.022] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:22:0)
[21:10:43.041] Build status: STARTED
[21:10:43.041] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:23:0) after 5m46s
[21:16:29.077] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:23:0)
[21:16:29.102] Build status: STARTED
[21:16:29.102] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:24:0) after 8m34s
[21:25:03.116] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:24:0)
[21:25:03.177] Build status: STARTED
[21:25:03.177] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:25:0) after 3m9s
[21:28:12.333] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:25:0)
[21:28:12.352] Build status: STARTED
[21:28:12.352] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:26:0) after 2m2s
[21:30:14.354] Handling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:26:0)
[21:30:14.379] Build status: STARTED
[21:30:14.379] Scheduling timer "check-buildbucket-build-status" (chromium-m132/android-official:8896332468780218032:27:0) after 9m5s
[21:38:47.924] Received PubSub notification, asking Buildbucket for the build status
[21:38:48.015] Build:
{
"id": "8730902406770501153",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "android-official"
},
"number": 86,
"createdBy": "project:chromium-m132",
"createTime": "2024-11-18T19:53:57.821838043Z",
"startTime": "2024-11-18T19:55:06.640199179Z",
"endTime": "2024-11-18T21:38:47.553733674Z",
"updateTime": "2024-11-18T21:38:47.553733674Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3163520ce9ce61d59e45d4a15dd4344ab01b1f6b",
"ref": "refs/branch-heads/6834"
}
}
}
[21:38:48.015] Invocation finished in 1h44m51.493483282s with status SUCCEEDED