[19:55:01.717] New invocation is queued and will start shortly
[19:55:02.885] Starting the invocation (attempt 1)
[19:55:02.915] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8be8188f5369bee996b106e27f5098eb45ada91"
[19:55:02.915] Popped gitiles commit info from properties and tags
[19:55:02.915] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:55:02.916] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:55:02.916] Buildbucket request:
{
"requestId": "8853842423179748496",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8853842423179748496",
"job": "chromium-m146/linux-cast-x64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "87e24199521335bc8475cc8299c701c24bf90510"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@87e24199521335bc8475cc8299c701c24bf90510",
"title": "87e24199521335bc8475cc8299c701c24bf90510",
"url": "https://chromium.googlesource.com/chromium/src/+/87e24199521335bc8475cc8299c701c24bf90510"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6b5b86a4fad7c5643acbb36a069f8a38a6a1170a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@6b5b86a4fad7c5643acbb36a069f8a38a6a1170a",
"title": "6b5b86a4fad7c5643acbb36a069f8a38a6a1170a",
"url": "https://chromium.googlesource.com/chromium/src/+/6b5b86a4fad7c5643acbb36a069f8a38a6a1170a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a5dc8005ecd5524ae6148edca93b3a6b9cd20924"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@a5dc8005ecd5524ae6148edca93b3a6b9cd20924",
"title": "a5dc8005ecd5524ae6148edca93b3a6b9cd20924",
"url": "https://chromium.googlesource.com/chromium/src/+/a5dc8005ecd5524ae6148edca93b3a6b9cd20924"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6454d4ec50cdc6cdb08be8b67c63d821349425b1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@6454d4ec50cdc6cdb08be8b67c63d821349425b1",
"title": "6454d4ec50cdc6cdb08be8b67c63d821349425b1",
"url": "https://chromium.googlesource.com/chromium/src/+/6454d4ec50cdc6cdb08be8b67c63d821349425b1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d668cfb41d3858d840da01ef486da4ce48f5b4a1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@d668cfb41d3858d840da01ef486da4ce48f5b4a1",
"title": "d668cfb41d3858d840da01ef486da4ce48f5b4a1",
"url": "https://chromium.googlesource.com/chromium/src/+/d668cfb41d3858d840da01ef486da4ce48f5b4a1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9954d8fc5645f1ce79ede8a78e8b13e1eb5a5852"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@9954d8fc5645f1ce79ede8a78e8b13e1eb5a5852",
"title": "9954d8fc5645f1ce79ede8a78e8b13e1eb5a5852",
"url": "https://chromium.googlesource.com/chromium/src/+/9954d8fc5645f1ce79ede8a78e8b13e1eb5a5852"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5d0f041656cc919fa6d602bc5e8ec6375948aa52"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@5d0f041656cc919fa6d602bc5e8ec6375948aa52",
"title": "5d0f041656cc919fa6d602bc5e8ec6375948aa52",
"url": "https://chromium.googlesource.com/chromium/src/+/5d0f041656cc919fa6d602bc5e8ec6375948aa52"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7ec3b0899e9328606d536401b732e0f281d3f364"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@7ec3b0899e9328606d536401b732e0f281d3f364",
"title": "7ec3b0899e9328606d536401b732e0f281d3f364",
"url": "https://chromium.googlesource.com/chromium/src/+/7ec3b0899e9328606d536401b732e0f281d3f364"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e3529bcd86bbb00e336e0d167a1431fd140db728"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@e3529bcd86bbb00e336e0d167a1431fd140db728",
"title": "e3529bcd86bbb00e336e0d167a1431fd140db728",
"url": "https://chromium.googlesource.com/chromium/src/+/e3529bcd86bbb00e336e0d167a1431fd140db728"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0a7540ed3dcd9ecd68b76ddccbb929c331f8f5a2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@0a7540ed3dcd9ecd68b76ddccbb929c331f8f5a2",
"title": "0a7540ed3dcd9ecd68b76ddccbb929c331f8f5a2",
"url": "https://chromium.googlesource.com/chromium/src/+/0a7540ed3dcd9ecd68b76ddccbb929c331f8f5a2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7aa31ca98e6160843ac5f5b6ad0497b17a7891f2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@7aa31ca98e6160843ac5f5b6ad0497b17a7891f2",
"title": "7aa31ca98e6160843ac5f5b6ad0497b17a7891f2",
"url": "https://chromium.googlesource.com/chromium/src/+/7aa31ca98e6160843ac5f5b6ad0497b17a7891f2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "911894e8ee6f0daacf8a1d28e204ce898f8f6853"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@911894e8ee6f0daacf8a1d28e204ce898f8f6853",
"title": "911894e8ee6f0daacf8a1d28e204ce898f8f6853",
"url": "https://chromium.googlesource.com/chromium/src/+/911894e8ee6f0daacf8a1d28e204ce898f8f6853"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "709662946a3dcafa1ab3cb8216cb1b8a3d6bb98c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@709662946a3dcafa1ab3cb8216cb1b8a3d6bb98c",
"title": "709662946a3dcafa1ab3cb8216cb1b8a3d6bb98c",
"url": "https://chromium.googlesource.com/chromium/src/+/709662946a3dcafa1ab3cb8216cb1b8a3d6bb98c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e8be8188f5369bee996b106e27f5098eb45ada91"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@e8be8188f5369bee996b106e27f5098eb45ada91",
"title": "e8be8188f5369bee996b106e27f5098eb45ada91",
"url": "https://chromium.googlesource.com/chromium/src/+/e8be8188f5369bee996b106e27f5098eb45ada91"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e8be8188f5369bee996b106e27f5098eb45ada91",
"ref": "refs/branch-heads/7680"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8853842423179748496"
},
{
"key": "scheduler_job_id",
"value": "chromium-m146/linux-cast-x64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:55:03.394] Scheduled build:
{
"id": "8688412361216548321",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 358,
"createdBy": "project:chromium-m146",
"createTime": "2026-03-02T19:55:02.969912970Z",
"updateTime": "2026-03-02T19:55:02.969912970Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e8be8188f5369bee996b106e27f5098eb45ada91",
"ref": "refs/branch-heads/7680"
}
}
}
[19:55:03.394] Task URL: https://cr-buildbucket.appspot.com/build/8688412361216548321
[19:55:03.394] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:2:0) after 3m40s
[19:55:04.416] Received PubSub notification, asking Buildbucket for the build status
[19:55:04.441] Build status: SCHEDULED
[19:56:00.726] Received PubSub notification, asking Buildbucket for the build status
[19:56:00.751] Build status: STARTED
[19:58:43.426] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:2:0)
[19:58:43.461] Build status: STARTED
[19:58:43.461] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:5:0) after 2m20s
[20:01:03.455] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:5:0)
[20:01:03.472] Build status: STARTED
[20:01:03.472] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:6:0) after 3m49s
[20:04:52.509] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:6:0)
[20:04:52.530] Build status: STARTED
[20:04:52.530] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:7:0) after 2m56s
[20:07:48.546] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:7:0)
[20:07:48.599] Build status: STARTED
[20:07:48.599] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:8:0) after 7m4s
[20:14:52.598] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:8:0)
[20:14:52.616] Build status: STARTED
[20:14:52.616] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:9:0) after 8m27s
[20:23:19.668] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:9:0)
[20:23:19.685] Build status: STARTED
[20:23:19.686] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:10:0) after 6m41s
[20:30:00.688] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:10:0)
[20:30:00.710] Build status: STARTED
[20:30:00.710] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:11:0) after 3m41s
[20:33:41.680] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:11:0)
[20:33:41.817] Build status: STARTED
[20:33:41.817] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:12:0) after 7m21s
[20:41:02.964] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:12:0)
[20:41:03.051] Build status: STARTED
[20:41:03.051] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:13:0) after 1m27s
[20:42:30.023] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:13:0)
[20:42:30.042] Build status: STARTED
[20:42:30.042] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:14:0) after 3m3s
[20:45:33.073] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:14:0)
[20:45:33.150] Build status: STARTED
[20:45:33.150] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:15:0) after 2m14s
[20:47:47.291] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:15:0)
[20:47:47.331] Build status: STARTED
[20:47:47.331] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:16:0) after 6m52s
[20:54:39.371] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:16:0)
[20:54:39.399] Build status: STARTED
[20:54:39.399] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:17:0) after 6m6s
[21:00:45.508] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:17:0)
[21:00:45.529] Build status: STARTED
[21:00:45.529] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:18:0) after 6m33s
[21:07:18.546] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:18:0)
[21:07:18.608] Build status: STARTED
[21:07:18.608] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:19:0) after 8m58s
[21:16:16.718] Handling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:19:0)
[21:16:16.733] Build status: STARTED
[21:16:16.733] Scheduling timer "check-buildbucket-build-status" (chromium-m146/linux-cast-x64-dbg:8853842423179748496:20:0) after 8m45s
[21:17:25.569] Received PubSub notification, asking Buildbucket for the build status
[21:17:25.587] Build:
{
"id": "8688412361216548321",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 358,
"createdBy": "project:chromium-m146",
"createTime": "2026-03-02T19:55:02.969912970Z",
"startTime": "2026-03-02T19:56:00.347507059Z",
"endTime": "2026-03-02T21:17:25.231630215Z",
"updateTime": "2026-03-02T21:17:25.231630215Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e8be8188f5369bee996b106e27f5098eb45ada91",
"ref": "refs/branch-heads/7680"
}
}
}
[21:17:25.587] Invocation finished in 1h22m23.873748619s with status SUCCEEDED