[18:43:32.780] New invocation is queued and will start shortly
[18:43:33.914] Starting the invocation (attempt 1)
[18:43:33.937] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7469e026e2e3cebe80abfa5289497ced3820a8fb"
[18:43:33.938] Popped gitiles commit info from properties and tags
[18:43:33.938] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:43:33.938] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:43:33.938] Buildbucket request:
{
"requestId": "8863721989803055008",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863721989803055008",
"job": "chromium-m143/win-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "664a49a9c2b0aea0d2bd70724266d8c7b29b10ba"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@664a49a9c2b0aea0d2bd70724266d8c7b29b10ba",
"title": "664a49a9c2b0aea0d2bd70724266d8c7b29b10ba",
"url": "https://chromium.googlesource.com/chromium/src/+/664a49a9c2b0aea0d2bd70724266d8c7b29b10ba"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1bba8d3e0380f932845f4090b3e197bb914b3b73"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@1bba8d3e0380f932845f4090b3e197bb914b3b73",
"title": "1bba8d3e0380f932845f4090b3e197bb914b3b73",
"url": "https://chromium.googlesource.com/chromium/src/+/1bba8d3e0380f932845f4090b3e197bb914b3b73"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ea185fe73c0bb1bd140df3e762e297750086dd28"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@ea185fe73c0bb1bd140df3e762e297750086dd28",
"title": "ea185fe73c0bb1bd140df3e762e297750086dd28",
"url": "https://chromium.googlesource.com/chromium/src/+/ea185fe73c0bb1bd140df3e762e297750086dd28"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8644c5c69d392dbfce8b939a5e14c7f6892689c1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@8644c5c69d392dbfce8b939a5e14c7f6892689c1",
"title": "8644c5c69d392dbfce8b939a5e14c7f6892689c1",
"url": "https://chromium.googlesource.com/chromium/src/+/8644c5c69d392dbfce8b939a5e14c7f6892689c1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "84c6a4b2e1a981e514198e8c8444d21c2bd8aa5d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@84c6a4b2e1a981e514198e8c8444d21c2bd8aa5d",
"title": "84c6a4b2e1a981e514198e8c8444d21c2bd8aa5d",
"url": "https://chromium.googlesource.com/chromium/src/+/84c6a4b2e1a981e514198e8c8444d21c2bd8aa5d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "676c0f2abd6e29d7771d6ba6980e4491db884d60"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@676c0f2abd6e29d7771d6ba6980e4491db884d60",
"title": "676c0f2abd6e29d7771d6ba6980e4491db884d60",
"url": "https://chromium.googlesource.com/chromium/src/+/676c0f2abd6e29d7771d6ba6980e4491db884d60"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "90312bdbeb2d4bdd2ddfff8f1f9f6d1429b286d8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@90312bdbeb2d4bdd2ddfff8f1f9f6d1429b286d8",
"title": "90312bdbeb2d4bdd2ddfff8f1f9f6d1429b286d8",
"url": "https://chromium.googlesource.com/chromium/src/+/90312bdbeb2d4bdd2ddfff8f1f9f6d1429b286d8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7eb02b0fc55f24b8c044e673b5d737173bf41af1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@7eb02b0fc55f24b8c044e673b5d737173bf41af1",
"title": "7eb02b0fc55f24b8c044e673b5d737173bf41af1",
"url": "https://chromium.googlesource.com/chromium/src/+/7eb02b0fc55f24b8c044e673b5d737173bf41af1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0ba4b1e57193e1f93f6c5a4d41ab1eed6be5e9c6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@0ba4b1e57193e1f93f6c5a4d41ab1eed6be5e9c6",
"title": "0ba4b1e57193e1f93f6c5a4d41ab1eed6be5e9c6",
"url": "https://chromium.googlesource.com/chromium/src/+/0ba4b1e57193e1f93f6c5a4d41ab1eed6be5e9c6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "147eeb30b811d32f9fa8530f49f6926087851ab3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@147eeb30b811d32f9fa8530f49f6926087851ab3",
"title": "147eeb30b811d32f9fa8530f49f6926087851ab3",
"url": "https://chromium.googlesource.com/chromium/src/+/147eeb30b811d32f9fa8530f49f6926087851ab3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "013bc39899edac241a6882a55d46725653dd6638"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@013bc39899edac241a6882a55d46725653dd6638",
"title": "013bc39899edac241a6882a55d46725653dd6638",
"url": "https://chromium.googlesource.com/chromium/src/+/013bc39899edac241a6882a55d46725653dd6638"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "34cc0c76e7235e5516ac7e36f811c82540600d69"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@34cc0c76e7235e5516ac7e36f811c82540600d69",
"title": "34cc0c76e7235e5516ac7e36f811c82540600d69",
"url": "https://chromium.googlesource.com/chromium/src/+/34cc0c76e7235e5516ac7e36f811c82540600d69"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c1651f0ec737bd7b870cb463c4946966e46eb314"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@c1651f0ec737bd7b870cb463c4946966e46eb314",
"title": "c1651f0ec737bd7b870cb463c4946966e46eb314",
"url": "https://chromium.googlesource.com/chromium/src/+/c1651f0ec737bd7b870cb463c4946966e46eb314"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7469e026e2e3cebe80abfa5289497ced3820a8fb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@7469e026e2e3cebe80abfa5289497ced3820a8fb",
"title": "7469e026e2e3cebe80abfa5289497ced3820a8fb",
"url": "https://chromium.googlesource.com/chromium/src/+/7469e026e2e3cebe80abfa5289497ced3820a8fb"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7469e026e2e3cebe80abfa5289497ced3820a8fb",
"ref": "refs/branch-heads/7499"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863721989803055008"
},
{
"key": "scheduler_job_id",
"value": "chromium-m143/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:43:34.375] Scheduled build:
{
"id": "8698291927878063841",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "win-official"
},
"number": 145,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-13T18:43:33.986861502Z",
"updateTime": "2025-11-13T18:43:33.986861502Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7469e026e2e3cebe80abfa5289497ced3820a8fb",
"ref": "refs/branch-heads/7499"
}
}
}
[18:43:34.375] Task URL: https://cr-buildbucket.appspot.com/build/8698291927878063841
[18:43:34.375] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:2:0) after 7m4s
[18:43:39.001] Received PubSub notification, asking Buildbucket for the build status
[18:43:39.025] Build status: SCHEDULED
[18:43:44.901] Received PubSub notification, asking Buildbucket for the build status
[18:43:44.921] Build status: STARTED
[18:50:38.425] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:2:0)
[18:50:38.446] Build status: STARTED
[18:50:38.446] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:5:0) after 8m4s
[18:58:42.630] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:5:0)
[18:58:42.651] Build status: STARTED
[18:58:42.651] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:6:0) after 1m18s
[19:00:01.217] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:6:0)
[19:00:01.279] Build status: STARTED
[19:00:01.279] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:7:0) after 5m48s
[19:05:49.295] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:7:0)
[19:05:49.309] Build status: STARTED
[19:05:49.309] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:8:0) after 1m0s
[19:06:49.325] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:8:0)
[19:06:49.343] Build status: STARTED
[19:06:49.343] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:9:0) after 8m53s
[19:15:42.417] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:9:0)
[19:15:42.431] Build status: STARTED
[19:15:42.432] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:10:0) after 2m37s
[19:18:19.666] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:10:0)
[19:18:19.687] Build status: STARTED
[19:18:19.687] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:11:0) after 4m20s
[19:22:39.730] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:11:0)
[19:22:39.747] Build status: STARTED
[19:22:39.747] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:12:0) after 6m20s
[19:28:59.768] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:12:0)
[19:28:59.783] Build status: STARTED
[19:28:59.783] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:13:0) after 3m20s
[19:32:20.059] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:13:0)
[19:32:20.082] Build status: STARTED
[19:32:20.082] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:14:0) after 6m0s
[19:38:20.058] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:14:0)
[19:38:20.100] Build status: STARTED
[19:38:20.100] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:15:0) after 7m36s
[19:45:56.114] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:15:0)
[19:45:56.312] Build status: STARTED
[19:45:56.312] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:16:0) after 9m25s
[19:55:21.349] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:16:0)
[19:55:21.367] Build status: STARTED
[19:55:21.367] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:17:0) after 3m54s
[19:59:15.380] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:17:0)
[19:59:15.434] Build status: STARTED
[19:59:15.435] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:18:0) after 9m46s
[20:09:01.438] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:18:0)
[20:09:01.484] Build status: STARTED
[20:09:01.484] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:19:0) after 3m10s
[20:12:11.504] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:19:0)
[20:12:11.518] Build status: STARTED
[20:12:11.518] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:20:0) after 7m46s
[20:19:57.638] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:20:0)
[20:19:57.696] Build status: STARTED
[20:19:57.696] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:21:0) after 9m55s
[20:29:52.712] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:21:0)
[20:29:52.734] Build status: STARTED
[20:29:52.734] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:22:0) after 6m55s
[20:36:47.748] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:22:0)
[20:36:47.817] Build status: STARTED
[20:36:47.817] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:23:0) after 4m31s
[20:41:18.904] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:23:0)
[20:41:18.923] Build status: STARTED
[20:41:18.923] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:24:0) after 8m42s
[20:50:00.970] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:24:0)
[20:50:00.989] Build status: STARTED
[20:50:00.989] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:25:0) after 7m17s
[20:57:18.012] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:25:0)
[20:57:18.027] Build status: STARTED
[20:57:18.027] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:26:0) after 3m21s
[21:00:39.039] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:26:0)
[21:00:39.057] Build status: STARTED
[21:00:39.057] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:27:0) after 3m46s
[21:04:25.041] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:27:0)
[21:04:25.063] Build status: STARTED
[21:04:25.063] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:28:0) after 9m49s
[21:14:14.141] Handling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:28:0)
[21:14:14.156] Build status: STARTED
[21:14:14.156] Scheduling timer "check-buildbucket-build-status" (chromium-m143/win-official:8863721989803055008:29:0) after 6m41s
[21:18:01.204] Received PubSub notification, asking Buildbucket for the build status
[21:18:01.220] Build:
{
"id": "8698291927878063841",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "win-official"
},
"number": 145,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-13T18:43:33.986861502Z",
"startTime": "2025-11-13T18:43:39.420755331Z",
"endTime": "2025-11-13T21:18:00.829307790Z",
"updateTime": "2025-11-13T21:18:00.829307790Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7469e026e2e3cebe80abfa5289497ced3820a8fb",
"ref": "refs/branch-heads/7499"
}
}
}
[21:18:01.221] Invocation finished in 2h34m28.45374816s with status SUCCEEDED