[17:03:16.436] New invocation is queued and will start shortly
[17:03:17.536] Starting the invocation (attempt 1)
[17:03:17.573] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cfdb812ef9102b18acd307f23bd7415912474987"
[17:03:17.573] Popped gitiles commit info from properties and tags
[17:03:17.573] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:03:17.574] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:03:17.576] Buildbucket request:
{
"requestId": "8849957559501335200",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8849957559501335200",
"job": "chromium-m148/linux-cast-x64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb5578dd0fcec8b6967dfb0d571fb718c3e71b40"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@cb5578dd0fcec8b6967dfb0d571fb718c3e71b40",
"title": "cb5578dd0fcec8b6967dfb0d571fb718c3e71b40",
"url": "https://chromium.googlesource.com/chromium/src/+/cb5578dd0fcec8b6967dfb0d571fb718c3e71b40"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "98c535a811a1ef597ea2e21f33eedc67499f1b50"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@98c535a811a1ef597ea2e21f33eedc67499f1b50",
"title": "98c535a811a1ef597ea2e21f33eedc67499f1b50",
"url": "https://chromium.googlesource.com/chromium/src/+/98c535a811a1ef597ea2e21f33eedc67499f1b50"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "384fa918f3ed018132e289565cd031ad083f8b0a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@384fa918f3ed018132e289565cd031ad083f8b0a",
"title": "384fa918f3ed018132e289565cd031ad083f8b0a",
"url": "https://chromium.googlesource.com/chromium/src/+/384fa918f3ed018132e289565cd031ad083f8b0a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c936a4e57f16dc659774b65f0b4eb9db89f3369b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@c936a4e57f16dc659774b65f0b4eb9db89f3369b",
"title": "c936a4e57f16dc659774b65f0b4eb9db89f3369b",
"url": "https://chromium.googlesource.com/chromium/src/+/c936a4e57f16dc659774b65f0b4eb9db89f3369b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "105f8d8ad17d1e203104d1732da8ae623f9f6c27"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@105f8d8ad17d1e203104d1732da8ae623f9f6c27",
"title": "105f8d8ad17d1e203104d1732da8ae623f9f6c27",
"url": "https://chromium.googlesource.com/chromium/src/+/105f8d8ad17d1e203104d1732da8ae623f9f6c27"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2aa17f4676fd413913fdb6154edba10af555525e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@2aa17f4676fd413913fdb6154edba10af555525e",
"title": "2aa17f4676fd413913fdb6154edba10af555525e",
"url": "https://chromium.googlesource.com/chromium/src/+/2aa17f4676fd413913fdb6154edba10af555525e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ba9d2cf934ac9b001385925fc6854f5e41816ee7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@ba9d2cf934ac9b001385925fc6854f5e41816ee7",
"title": "ba9d2cf934ac9b001385925fc6854f5e41816ee7",
"url": "https://chromium.googlesource.com/chromium/src/+/ba9d2cf934ac9b001385925fc6854f5e41816ee7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "84b66d3b1b172f46a256205d6f265f202eddd653"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@84b66d3b1b172f46a256205d6f265f202eddd653",
"title": "84b66d3b1b172f46a256205d6f265f202eddd653",
"url": "https://chromium.googlesource.com/chromium/src/+/84b66d3b1b172f46a256205d6f265f202eddd653"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3d03385f8f9a50252418a6280264b823b7905013"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@3d03385f8f9a50252418a6280264b823b7905013",
"title": "3d03385f8f9a50252418a6280264b823b7905013",
"url": "https://chromium.googlesource.com/chromium/src/+/3d03385f8f9a50252418a6280264b823b7905013"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "af319a510e6ba1153a7d3a78d95537aa7c62ca9f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@af319a510e6ba1153a7d3a78d95537aa7c62ca9f",
"title": "af319a510e6ba1153a7d3a78d95537aa7c62ca9f",
"url": "https://chromium.googlesource.com/chromium/src/+/af319a510e6ba1153a7d3a78d95537aa7c62ca9f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "abd640c44c51bcb82294c2820c8ac5c24c797b00"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@abd640c44c51bcb82294c2820c8ac5c24c797b00",
"title": "abd640c44c51bcb82294c2820c8ac5c24c797b00",
"url": "https://chromium.googlesource.com/chromium/src/+/abd640c44c51bcb82294c2820c8ac5c24c797b00"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "182709be7902f77586a57cc010d43e8cad7d8be6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@182709be7902f77586a57cc010d43e8cad7d8be6",
"title": "182709be7902f77586a57cc010d43e8cad7d8be6",
"url": "https://chromium.googlesource.com/chromium/src/+/182709be7902f77586a57cc010d43e8cad7d8be6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a4d5e62fcb9bb01d6f5473f2052729fa995697a7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@a4d5e62fcb9bb01d6f5473f2052729fa995697a7",
"title": "a4d5e62fcb9bb01d6f5473f2052729fa995697a7",
"url": "https://chromium.googlesource.com/chromium/src/+/a4d5e62fcb9bb01d6f5473f2052729fa995697a7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cfdb812ef9102b18acd307f23bd7415912474987"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@cfdb812ef9102b18acd307f23bd7415912474987",
"title": "cfdb812ef9102b18acd307f23bd7415912474987",
"url": "https://chromium.googlesource.com/chromium/src/+/cfdb812ef9102b18acd307f23bd7415912474987"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cfdb812ef9102b18acd307f23bd7415912474987",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8849957559501335200"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/linux-cast-x64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:03:18.300] Scheduled build:
{
"id": "8684527497520501137",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 107,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-14T17:03:17.698153121Z",
"updateTime": "2026-04-14T17:03:17.698153121Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cfdb812ef9102b18acd307f23bd7415912474987",
"ref": "refs/branch-heads/7778"
}
}
}
[17:03:18.300] Task URL: https://cr-buildbucket.appspot.com/build/8684527497520501137
[17:03:18.300] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:2:0) after 1m56s
[17:03:18.390] Received PubSub notification, asking Buildbucket for the build status
[17:03:18.409] Build status: SCHEDULED
[17:04:13.732] Received PubSub notification, asking Buildbucket for the build status
[17:04:13.757] Build status: STARTED
[17:05:14.317] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:2:0)
[17:05:14.337] Build status: STARTED
[17:05:14.337] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:5:0) after 3m46s
[17:09:00.363] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:5:0)
[17:09:00.393] Build status: STARTED
[17:09:00.393] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:6:0) after 6m55s
[17:15:55.410] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:6:0)
[17:15:55.438] Build status: STARTED
[17:15:55.439] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:7:0) after 7m24s
[17:23:19.457] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:7:0)
[17:23:19.554] Build status: STARTED
[17:23:19.555] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:8:0) after 3m14s
[17:26:33.739] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:8:0)
[17:26:33.755] Build status: STARTED
[17:26:33.755] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:9:0) after 4m39s
[17:31:12.878] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:9:0)
[17:31:12.919] Build status: STARTED
[17:31:12.919] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:10:0) after 8m33s
[17:39:46.038] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:10:0)
[17:39:46.224] Build status: STARTED
[17:39:46.224] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:11:0) after 4m31s
[17:44:17.240] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:11:0)
[17:44:17.292] Build status: STARTED
[17:44:17.292] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:12:0) after 1m57s
[17:46:14.303] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:12:0)
[17:46:14.393] Build status: STARTED
[17:46:14.393] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:13:0) after 6m47s
[17:53:01.433] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:13:0)
[17:53:01.453] Build status: STARTED
[17:53:01.453] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:14:0) after 3m51s
[17:56:52.458] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:14:0)
[17:56:52.509] Build status: STARTED
[17:56:52.509] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:15:0) after 6m17s
[18:03:09.600] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:15:0)
[18:03:09.621] Build status: STARTED
[18:03:09.621] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:16:0) after 1m6s
[18:04:15.796] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:16:0)
[18:04:15.814] Build status: STARTED
[18:04:15.814] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:17:0) after 1m49s
[18:06:04.910] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:17:0)
[18:06:04.961] Build status: STARTED
[18:06:04.961] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:18:0) after 9m18s
[18:15:23.073] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:18:0)
[18:15:23.102] Build status: STARTED
[18:15:23.102] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:19:0) after 3m32s
[18:18:55.171] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:19:0)
[18:18:55.223] Build status: STARTED
[18:18:55.223] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:20:0) after 1m48s
[18:20:43.236] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:20:0)
[18:20:43.250] Build status: STARTED
[18:20:43.251] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:21:0) after 1m42s
[18:22:25.541] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:21:0)
[18:22:25.561] Build status: STARTED
[18:22:25.562] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:22:0) after 5m57s
[18:28:22.588] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:22:0)
[18:28:22.615] Build status: STARTED
[18:28:22.615] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:23:0) after 7m1s
[18:35:23.680] Handling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:23:0)
[18:35:23.704] Build status: STARTED
[18:35:23.704] Scheduling timer "check-buildbucket-build-status" (chromium-m148/linux-cast-x64-dbg:8849957559501335200:24:0) after 9m44s
[18:39:37.384] Received PubSub notification, asking Buildbucket for the build status
[18:39:37.440] Build:
{
"id": "8684527497520501137",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 107,
"createdBy": "project:chromium-m148",
"createTime": "2026-04-14T17:03:17.698153121Z",
"startTime": "2026-04-14T17:04:13.553940661Z",
"endTime": "2026-04-14T18:39:36.316683311Z",
"updateTime": "2026-04-14T18:39:36.316683311Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cfdb812ef9102b18acd307f23bd7415912474987",
"ref": "refs/branch-heads/7778"
}
}
}
[18:39:37.440] Invocation finished in 1h36m21.014421213s with status SUCCEEDED