[04:06:54.500] New invocation is queued and will start shortly
[04:06:55.561] Starting the invocation (attempt 1)
[04:06:55.585] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1"
[04:06:55.585] Popped gitiles commit info from properties and tags
[04:06:55.585] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:06:55.585] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:06:55.586] Buildbucket request:
{
"requestId": "8857435355440895104",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857435355440895104",
"job": "chromium-m145/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ae50194bc663d82df071326a15c14ea92240c087"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@ae50194bc663d82df071326a15c14ea92240c087",
"title": "ae50194bc663d82df071326a15c14ea92240c087",
"url": "https://chromium.googlesource.com/chromium/src/+/ae50194bc663d82df071326a15c14ea92240c087"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "da59932fc0bd7e8ba11d45d05361da884238647b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@da59932fc0bd7e8ba11d45d05361da884238647b",
"title": "da59932fc0bd7e8ba11d45d05361da884238647b",
"url": "https://chromium.googlesource.com/chromium/src/+/da59932fc0bd7e8ba11d45d05361da884238647b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fe944050260c4e22f8440a0db16a334308804b52"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@fe944050260c4e22f8440a0db16a334308804b52",
"title": "fe944050260c4e22f8440a0db16a334308804b52",
"url": "https://chromium.googlesource.com/chromium/src/+/fe944050260c4e22f8440a0db16a334308804b52"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b95a75afae8e736083eb3b3a5a899ee1fa2101d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@b95a75afae8e736083eb3b3a5a899ee1fa2101d3",
"title": "b95a75afae8e736083eb3b3a5a899ee1fa2101d3",
"url": "https://chromium.googlesource.com/chromium/src/+/b95a75afae8e736083eb3b3a5a899ee1fa2101d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "292ff0fcafe2091609ffc83e66b11847ec8c88f6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@292ff0fcafe2091609ffc83e66b11847ec8c88f6",
"title": "292ff0fcafe2091609ffc83e66b11847ec8c88f6",
"url": "https://chromium.googlesource.com/chromium/src/+/292ff0fcafe2091609ffc83e66b11847ec8c88f6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "89250f5d461f0b786efabc3b576d68a9072828d8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@89250f5d461f0b786efabc3b576d68a9072828d8",
"title": "89250f5d461f0b786efabc3b576d68a9072828d8",
"url": "https://chromium.googlesource.com/chromium/src/+/89250f5d461f0b786efabc3b576d68a9072828d8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9e4a4c6fedeb1fb6bb617879a6dd0a16fcf14e32"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@9e4a4c6fedeb1fb6bb617879a6dd0a16fcf14e32",
"title": "9e4a4c6fedeb1fb6bb617879a6dd0a16fcf14e32",
"url": "https://chromium.googlesource.com/chromium/src/+/9e4a4c6fedeb1fb6bb617879a6dd0a16fcf14e32"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8b9c06f977ea13584eea4a7a4f3dd947f2cab585"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@8b9c06f977ea13584eea4a7a4f3dd947f2cab585",
"title": "8b9c06f977ea13584eea4a7a4f3dd947f2cab585",
"url": "https://chromium.googlesource.com/chromium/src/+/8b9c06f977ea13584eea4a7a4f3dd947f2cab585"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0b7b48eb0bdea579c9d5d39a512899d760ca6563"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@0b7b48eb0bdea579c9d5d39a512899d760ca6563",
"title": "0b7b48eb0bdea579c9d5d39a512899d760ca6563",
"url": "https://chromium.googlesource.com/chromium/src/+/0b7b48eb0bdea579c9d5d39a512899d760ca6563"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "58f24ba4b1aa7690fc3b42ce65760dc3cffdfd61"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@58f24ba4b1aa7690fc3b42ce65760dc3cffdfd61",
"title": "58f24ba4b1aa7690fc3b42ce65760dc3cffdfd61",
"url": "https://chromium.googlesource.com/chromium/src/+/58f24ba4b1aa7690fc3b42ce65760dc3cffdfd61"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6d74296963b2c36122e792ce4fbacf1cce7d87f3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@6d74296963b2c36122e792ce4fbacf1cce7d87f3",
"title": "6d74296963b2c36122e792ce4fbacf1cce7d87f3",
"url": "https://chromium.googlesource.com/chromium/src/+/6d74296963b2c36122e792ce4fbacf1cce7d87f3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6e1cea9c1e590b9924797a9388e00c15fbeda29d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@6e1cea9c1e590b9924797a9388e00c15fbeda29d",
"title": "6e1cea9c1e590b9924797a9388e00c15fbeda29d",
"url": "https://chromium.googlesource.com/chromium/src/+/6e1cea9c1e590b9924797a9388e00c15fbeda29d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bf2842b7dad9f24388912c86ad363c3803f5bace"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@bf2842b7dad9f24388912c86ad363c3803f5bace",
"title": "bf2842b7dad9f24388912c86ad363c3803f5bace",
"url": "https://chromium.googlesource.com/chromium/src/+/bf2842b7dad9f24388912c86ad363c3803f5bace"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5bc8ebb014eff6a1f51c5ffaf0136efb36984055"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@5bc8ebb014eff6a1f51c5ffaf0136efb36984055",
"title": "5bc8ebb014eff6a1f51c5ffaf0136efb36984055",
"url": "https://chromium.googlesource.com/chromium/src/+/5bc8ebb014eff6a1f51c5ffaf0136efb36984055"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5daf4b2d3daf72e2851c561bdec56e6343ea6477"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@5daf4b2d3daf72e2851c561bdec56e6343ea6477",
"title": "5daf4b2d3daf72e2851c561bdec56e6343ea6477",
"url": "https://chromium.googlesource.com/chromium/src/+/5daf4b2d3daf72e2851c561bdec56e6343ea6477"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5b7bcbd2f68259e3bda7796e6ad121866c4518d5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@5b7bcbd2f68259e3bda7796e6ad121866c4518d5",
"title": "5b7bcbd2f68259e3bda7796e6ad121866c4518d5",
"url": "https://chromium.googlesource.com/chromium/src/+/5b7bcbd2f68259e3bda7796e6ad121866c4518d5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1",
"title": "aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1",
"url": "https://chromium.googlesource.com/chromium/src/+/aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1",
"ref": "refs/branch-heads/7632"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857435355440895104"
},
{
"key": "scheduler_job_id",
"value": "chromium-m145/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:06:56.295] Scheduled build:
{
"id": "8692005293602165153",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 127,
"createdBy": "project:chromium-m145",
"createTime": "2026-01-22T04:06:55.632143867Z",
"updateTime": "2026-01-22T04:06:55.632143867Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1",
"ref": "refs/branch-heads/7632"
}
},
"canary": true
}
[04:06:56.295] Task URL: https://cr-buildbucket.appspot.com/build/8692005293602165153
[04:06:56.295] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:2:0) after 7m58s
[04:06:57.157] Received PubSub notification, asking Buildbucket for the build status
[04:06:57.173] Build status: SCHEDULED
[04:07:50.281] Received PubSub notification, asking Buildbucket for the build status
[04:07:50.296] Build status: STARTED
[04:14:54.307] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:2:0)
[04:14:54.328] Build status: STARTED
[04:14:54.328] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:5:0) after 2m8s
[04:17:02.343] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:5:0)
[04:17:02.359] Build status: STARTED
[04:17:02.359] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:6:0) after 5m10s
[04:22:12.374] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:6:0)
[04:22:12.394] Build status: STARTED
[04:22:12.394] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:7:0) after 9m33s
[04:31:45.453] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:7:0)
[04:31:45.473] Build status: STARTED
[04:31:45.473] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:8:0) after 2m20s
[04:34:05.490] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:8:0)
[04:34:05.526] Build status: STARTED
[04:34:05.526] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:9:0) after 9m47s
[04:43:52.529] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:9:0)
[04:43:52.558] Build status: STARTED
[04:43:52.558] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:10:0) after 4m44s
[04:48:36.572] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:10:0)
[04:48:36.589] Build status: STARTED
[04:48:36.589] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:11:0) after 7m38s
[04:56:14.632] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:11:0)
[04:56:14.690] Build status: STARTED
[04:56:14.690] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:12:0) after 3m18s
[04:59:32.726] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:12:0)
[04:59:32.754] Build status: STARTED
[04:59:32.754] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:13:0) after 8m54s
[05:08:26.770] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:13:0)
[05:08:26.786] Build status: STARTED
[05:08:26.790] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:14:0) after 7m31s
[05:15:57.816] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:14:0)
[05:15:57.847] Build status: STARTED
[05:15:57.847] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:15:0) after 8m57s
[05:24:54.895] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:15:0)
[05:24:54.919] Build status: STARTED
[05:24:54.919] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:16:0) after 8m20s
[05:33:14.936] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:16:0)
[05:33:14.950] Build status: STARTED
[05:33:14.950] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:17:0) after 8m11s
[05:41:25.964] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:17:0)
[05:41:25.980] Build status: STARTED
[05:41:25.980] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:18:0) after 5m51s
[05:47:16.998] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:18:0)
[05:47:17.014] Build status: STARTED
[05:47:17.014] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:19:0) after 1m51s
[05:49:08.010] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:19:0)
[05:49:08.027] Build status: STARTED
[05:49:08.027] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:20:0) after 8m23s
[05:57:31.048] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:20:0)
[05:57:31.065] Build status: STARTED
[05:57:31.065] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:21:0) after 9m10s
[06:06:41.084] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:21:0)
[06:06:41.102] Build status: STARTED
[06:06:41.102] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:22:0) after 7m56s
[06:14:37.125] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:22:0)
[06:14:37.138] Build status: STARTED
[06:14:37.138] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:23:0) after 6m0s
[06:20:37.113] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:23:0)
[06:20:37.152] Build status: STARTED
[06:20:37.153] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:24:0) after 2m52s
[06:23:29.187] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:24:0)
[06:23:29.210] Build status: STARTED
[06:23:29.210] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:25:0) after 2m5s
[06:25:34.227] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:25:0)
[06:25:34.263] Build status: STARTED
[06:25:34.263] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:26:0) after 1m38s
[06:27:12.292] Handling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:26:0)
[06:27:12.336] Build status: STARTED
[06:27:12.336] Scheduling timer "check-buildbucket-build-status" (chromium-m145/linux-chromeos-dbg:8857435355440895104:27:0) after 5m36s
[06:28:23.610] Received PubSub notification, asking Buildbucket for the build status
[06:28:23.629] Build:
{
"id": "8692005293602165153",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 127,
"createdBy": "project:chromium-m145",
"createTime": "2026-01-22T04:06:55.632143867Z",
"startTime": "2026-01-22T04:07:49.901912021Z",
"endTime": "2026-01-22T06:28:23.262489304Z",
"updateTime": "2026-01-22T06:28:23.262489304Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "aa3ccddbf95b9b04a3b28cfa28d747d9f1f9e4b1",
"ref": "refs/branch-heads/7632"
}
},
"canary": true
}
[06:28:23.629] Invocation finished in 2h21m29.13446446s with status SUCCEEDED