[00:39:07.675] New invocation is queued and will start shortly
[00:39:08.812] Starting the invocation (attempt 1)
[00:39:08.851] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e751d03e749d05903a9307e980d689b5b2723eb0"
[00:39:08.851] Popped gitiles commit info from properties and tags
[00:39:08.851] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:39:08.852] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:39:08.852] Buildbucket request:
{
"requestId": "8844764852560982176",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8844764852560982176",
"job": "chromium-m148/win-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e751d03e749d05903a9307e980d689b5b2723eb0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7778@e751d03e749d05903a9307e980d689b5b2723eb0",
"title": "e751d03e749d05903a9307e980d689b5b2723eb0",
"url": "https://chromium.googlesource.com/chromium/src/+/e751d03e749d05903a9307e980d689b5b2723eb0"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e751d03e749d05903a9307e980d689b5b2723eb0",
"ref": "refs/branch-heads/7778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8844764852560982176"
},
{
"key": "scheduler_job_id",
"value": "chromium-m148/win-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:39:09.363] Scheduled build:
{
"id": "8679334790582829185",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-official"
},
"number": 455,
"createdBy": "project:chromium-m148",
"createTime": "2026-06-11T00:39:08.937940534Z",
"updateTime": "2026-06-11T00:39:08.937940534Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e751d03e749d05903a9307e980d689b5b2723eb0",
"ref": "refs/branch-heads/7778"
}
}
}
[00:39:09.364] Task URL: https://cr-buildbucket.appspot.com/build/8679334790582829185
[00:39:09.364] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:2:0) after 7m50s
[00:39:10.419] Received PubSub notification, asking Buildbucket for the build status
[00:39:10.438] Build status: SCHEDULED
[00:41:26.534] Received PubSub notification, asking Buildbucket for the build status
[00:41:26.564] Build status: STARTED
[00:46:59.377] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:2:0)
[00:46:59.397] Build status: STARTED
[00:46:59.397] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:5:0) after 1m30s
[00:48:29.411] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:5:0)
[00:48:29.469] Build status: STARTED
[00:48:29.469] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:6:0) after 3m5s
[00:51:34.484] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:6:0)
[00:51:34.503] Build status: STARTED
[00:51:34.503] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:7:0) after 4m53s
[00:56:27.568] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:7:0)
[00:56:27.615] Build status: STARTED
[00:56:27.615] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:8:0) after 2m46s
[00:59:13.650] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:8:0)
[00:59:13.677] Build status: STARTED
[00:59:13.677] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:9:0) after 9m15s
[01:08:28.693] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:9:0)
[01:08:28.712] Build status: STARTED
[01:08:28.712] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:10:0) after 4m19s
[01:12:47.728] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:10:0)
[01:12:47.755] Build status: STARTED
[01:12:47.755] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:11:0) after 9m36s
[01:22:23.798] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:11:0)
[01:22:23.820] Build status: STARTED
[01:22:23.820] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:12:0) after 4m48s
[01:27:11.837] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:12:0)
[01:27:11.859] Build status: STARTED
[01:27:11.859] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:13:0) after 9m44s
[01:36:55.954] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:13:0)
[01:36:56.008] Build status: STARTED
[01:36:56.008] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:14:0) after 3m24s
[01:40:20.000] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:14:0)
[01:40:20.018] Build status: STARTED
[01:40:20.018] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:15:0) after 2m42s
[01:43:02.138] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:15:0)
[01:43:02.154] Build status: STARTED
[01:43:02.154] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:16:0) after 3m55s
[01:46:57.170] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:16:0)
[01:46:57.189] Build status: STARTED
[01:46:57.189] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:17:0) after 4m12s
[01:51:09.213] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:17:0)
[01:51:09.233] Build status: STARTED
[01:51:09.233] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:18:0) after 2m51s
[01:54:00.207] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:18:0)
[01:54:00.271] Build status: STARTED
[01:54:00.271] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:19:0) after 2m57s
[01:56:57.338] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:19:0)
[01:56:57.363] Build status: STARTED
[01:56:57.363] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:20:0) after 1m14s
[01:58:11.377] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:20:0)
[01:58:11.394] Build status: STARTED
[01:58:11.394] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:21:0) after 7m32s
[02:05:43.409] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:21:0)
[02:05:43.430] Build status: STARTED
[02:05:43.430] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:22:0) after 2m13s
[02:07:56.448] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:22:0)
[02:07:56.469] Build status: STARTED
[02:07:56.470] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:23:0) after 4m0s
[02:11:56.477] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:23:0)
[02:11:56.581] Build status: STARTED
[02:11:56.581] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:24:0) after 9m9s
[02:21:05.650] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:24:0)
[02:21:05.741] Build status: STARTED
[02:21:05.741] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:25:0) after 5m25s
[02:26:30.782] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:25:0)
[02:26:30.812] Build status: STARTED
[02:26:30.812] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:26:0) after 9m4s
[02:35:34.825] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:26:0)
[02:35:34.859] Build status: STARTED
[02:35:34.859] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:27:0) after 3m29s
[02:39:03.873] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:27:0)
[02:39:03.891] Build status: STARTED
[02:39:03.891] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:28:0) after 6m45s
[02:45:48.911] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:28:0)
[02:45:48.936] Build status: STARTED
[02:45:48.936] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:29:0) after 1m34s
[02:47:22.949] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:29:0)
[02:47:23.019] Build status: STARTED
[02:47:23.019] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:30:0) after 6m7s
[02:53:30.052] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:30:0)
[02:53:30.067] Build status: STARTED
[02:53:30.067] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:31:0) after 8m11s
[03:01:41.063] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:31:0)
[03:01:41.230] Build status: STARTED
[03:01:41.230] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:32:0) after 9m31s
[03:11:12.204] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:32:0)
[03:11:12.226] Build status: STARTED
[03:11:12.226] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:33:0) after 8m39s
[03:19:51.257] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:33:0)
[03:19:51.275] Build status: STARTED
[03:19:51.275] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:34:0) after 7m2s
[03:26:53.290] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:34:0)
[03:26:53.310] Build status: STARTED
[03:26:53.310] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:35:0) after 7m26s
[03:34:19.324] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:35:0)
[03:34:19.345] Build status: STARTED
[03:34:19.345] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:36:0) after 4m57s
[03:39:16.395] Handling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:36:0)
[03:39:16.412] Build status: STARTED
[03:39:16.412] Scheduling timer "check-buildbucket-build-status" (chromium-m148/win-official:8844764852560982176:37:0) after 8m48s
[03:44:41.806] Received PubSub notification, asking Buildbucket for the build status
[03:44:41.829] Build:
{
"id": "8679334790582829185",
"builder": {
"project": "chromium-m148",
"bucket": "ci",
"builder": "win-official"
},
"number": 455,
"createdBy": "project:chromium-m148",
"createTime": "2026-06-11T00:39:08.937940534Z",
"startTime": "2026-06-11T00:41:26.376951918Z",
"endTime": "2026-06-11T03:44:31.546701923Z",
"updateTime": "2026-06-11T03:44:31.546701923Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e751d03e749d05903a9307e980d689b5b2723eb0",
"ref": "refs/branch-heads/7778"
}
}
}
[03:44:41.829] Invocation finished in 3h5m34.16176762s with status SUCCEEDED