[18:04:02.892] New invocation is queued and will start shortly
[18:04:04.061] Starting the invocation (attempt 1)
[18:04:04.085] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d69780e1b1daf932203c1b6d36168eefb3ac511"
[18:04:04.085] Popped gitiles commit info from properties and tags
[18:04:04.085] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:04:04.085] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:04:04.085] Buildbucket request:
{
"requestId": "8868073129198755536",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868073129198755536",
"job": "chromium-m140/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a2ebf528d3e83501e84e86501890c48f311f2b0a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@a2ebf528d3e83501e84e86501890c48f311f2b0a",
"title": "a2ebf528d3e83501e84e86501890c48f311f2b0a",
"url": "https://chromium.googlesource.com/chromium/src/+/a2ebf528d3e83501e84e86501890c48f311f2b0a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c43182fba6f739f77a0616af66a6bc405ce69dfe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@c43182fba6f739f77a0616af66a6bc405ce69dfe",
"title": "c43182fba6f739f77a0616af66a6bc405ce69dfe",
"url": "https://chromium.googlesource.com/chromium/src/+/c43182fba6f739f77a0616af66a6bc405ce69dfe"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8873ac905d985a89d1c31ef1d95dca05f264ea93"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@8873ac905d985a89d1c31ef1d95dca05f264ea93",
"title": "8873ac905d985a89d1c31ef1d95dca05f264ea93",
"url": "https://chromium.googlesource.com/chromium/src/+/8873ac905d985a89d1c31ef1d95dca05f264ea93"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b1c6271a1a6a01396869e21c73b165b5536347cd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@b1c6271a1a6a01396869e21c73b165b5536347cd",
"title": "b1c6271a1a6a01396869e21c73b165b5536347cd",
"url": "https://chromium.googlesource.com/chromium/src/+/b1c6271a1a6a01396869e21c73b165b5536347cd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "781f39e8237d3b177264189cf9338a3f97bb3657"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@781f39e8237d3b177264189cf9338a3f97bb3657",
"title": "781f39e8237d3b177264189cf9338a3f97bb3657",
"url": "https://chromium.googlesource.com/chromium/src/+/781f39e8237d3b177264189cf9338a3f97bb3657"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "24f6028408179f22a31cf36755707b4718216eb2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@24f6028408179f22a31cf36755707b4718216eb2",
"title": "24f6028408179f22a31cf36755707b4718216eb2",
"url": "https://chromium.googlesource.com/chromium/src/+/24f6028408179f22a31cf36755707b4718216eb2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9224b28e9213a6049e72a5715ca233dfe5bd0476"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@9224b28e9213a6049e72a5715ca233dfe5bd0476",
"title": "9224b28e9213a6049e72a5715ca233dfe5bd0476",
"url": "https://chromium.googlesource.com/chromium/src/+/9224b28e9213a6049e72a5715ca233dfe5bd0476"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c2f00043ca713765a4f71ceae6db46ec52c00198"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@c2f00043ca713765a4f71ceae6db46ec52c00198",
"title": "c2f00043ca713765a4f71ceae6db46ec52c00198",
"url": "https://chromium.googlesource.com/chromium/src/+/c2f00043ca713765a4f71ceae6db46ec52c00198"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cd833f31edb0b85b1eace6ccec957f721d3b0323"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@cd833f31edb0b85b1eace6ccec957f721d3b0323",
"title": "cd833f31edb0b85b1eace6ccec957f721d3b0323",
"url": "https://chromium.googlesource.com/chromium/src/+/cd833f31edb0b85b1eace6ccec957f721d3b0323"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "79cab690cf57c58147e7bf890daa4aa14d394ab5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@79cab690cf57c58147e7bf890daa4aa14d394ab5",
"title": "79cab690cf57c58147e7bf890daa4aa14d394ab5",
"url": "https://chromium.googlesource.com/chromium/src/+/79cab690cf57c58147e7bf890daa4aa14d394ab5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7d69780e1b1daf932203c1b6d36168eefb3ac511"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@7d69780e1b1daf932203c1b6d36168eefb3ac511",
"title": "7d69780e1b1daf932203c1b6d36168eefb3ac511",
"url": "https://chromium.googlesource.com/chromium/src/+/7d69780e1b1daf932203c1b6d36168eefb3ac511"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7d69780e1b1daf932203c1b6d36168eefb3ac511",
"ref": "refs/branch-heads/7339"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868073129198755536"
},
{
"key": "scheduler_job_id",
"value": "chromium-m140/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:04:04.886] Scheduled build:
{
"id": "8702643067183053633",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "mac-official"
},
"number": 412,
"createdBy": "project:chromium-m140",
"createTime": "2025-09-26T18:04:04.184803397Z",
"updateTime": "2025-09-26T18:04:04.184803397Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7d69780e1b1daf932203c1b6d36168eefb3ac511",
"ref": "refs/branch-heads/7339"
}
}
}
[18:04:04.886] Task URL: https://cr-buildbucket.appspot.com/build/8702643067183053633
[18:04:04.886] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:2:0) after 4m19s
[18:04:05.743] Received PubSub notification, asking Buildbucket for the build status
[18:04:05.761] Build status: SCHEDULED
[18:04:13.407] Received PubSub notification, asking Buildbucket for the build status
[18:04:13.457] Build status: STARTED
[18:08:23.900] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:2:0)
[18:08:23.916] Build status: STARTED
[18:08:23.916] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:5:0) after 5m36s
[18:14:00.029] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:5:0)
[18:14:00.052] Build status: STARTED
[18:14:00.052] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:6:0) after 9m54s
[18:23:54.095] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:6:0)
[18:23:54.282] Build status: STARTED
[18:23:54.282] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:7:0) after 8m17s
[18:32:11.296] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:7:0)
[18:32:11.313] Build status: STARTED
[18:32:11.313] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:8:0) after 9m1s
[18:41:12.331] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:8:0)
[18:41:12.348] Build status: STARTED
[18:41:12.348] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:9:0) after 8m20s
[18:49:32.479] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:9:0)
[18:49:32.497] Build status: STARTED
[18:49:32.498] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:10:0) after 8m7s
[18:57:39.520] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:10:0)
[18:57:39.594] Build status: STARTED
[18:57:39.594] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:11:0) after 6m37s
[19:04:16.649] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:11:0)
[19:04:16.711] Build status: STARTED
[19:04:16.711] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:12:0) after 3m7s
[19:07:23.727] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:12:0)
[19:07:23.750] Build status: STARTED
[19:07:23.750] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:13:0) after 3m55s
[19:11:18.780] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:13:0)
[19:11:18.797] Build status: STARTED
[19:11:18.797] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:14:0) after 7m34s
[19:18:52.811] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:14:0)
[19:18:52.838] Build status: STARTED
[19:18:52.838] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:15:0) after 5m47s
[19:24:39.965] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:15:0)
[19:24:39.979] Build status: STARTED
[19:24:39.979] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:16:0) after 7m10s
[19:31:50.049] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:16:0)
[19:31:50.068] Build status: STARTED
[19:31:50.069] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:17:0) after 4m21s
[19:36:11.162] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:17:0)
[19:36:11.201] Build status: STARTED
[19:36:11.201] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:18:0) after 1m31s
[19:37:42.215] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:18:0)
[19:37:42.232] Build status: STARTED
[19:37:42.232] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:19:0) after 5m52s
[19:43:34.297] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:19:0)
[19:43:34.350] Build status: STARTED
[19:43:34.350] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:20:0) after 7m27s
[19:51:01.554] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:20:0)
[19:51:01.663] Build status: STARTED
[19:51:01.663] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:21:0) after 6m20s
[19:57:21.707] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:21:0)
[19:57:21.730] Build status: STARTED
[19:57:21.730] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:22:0) after 7m51s
[20:05:12.849] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:22:0)
[20:05:12.882] Build status: STARTED
[20:05:12.882] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:23:0) after 9m56s
[20:15:08.943] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:23:0)
[20:15:08.961] Build status: STARTED
[20:15:08.961] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:24:0) after 3m48s
[20:18:56.975] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:24:0)
[20:18:57.002] Build status: STARTED
[20:18:57.002] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:25:0) after 2m40s
[20:21:37.039] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:25:0)
[20:21:37.147] Build status: STARTED
[20:21:37.147] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:26:0) after 3m16s
[20:24:53.210] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:26:0)
[20:24:53.227] Build status: STARTED
[20:24:53.228] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:27:0) after 2m13s
[20:27:06.278] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:27:0)
[20:27:06.303] Build status: STARTED
[20:27:06.303] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:28:0) after 5m12s
[20:32:18.327] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:28:0)
[20:32:18.390] Build status: STARTED
[20:32:18.390] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:29:0) after 7m55s
[20:40:13.408] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:29:0)
[20:40:13.427] Build status: STARTED
[20:40:13.427] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:30:0) after 5m53s
[20:46:06.570] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:30:0)
[20:46:06.588] Build status: STARTED
[20:46:06.588] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:31:0) after 8m34s
[20:54:40.657] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:31:0)
[20:54:40.673] Build status: STARTED
[20:54:40.673] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8868073129198755536:32:0) after 7m21s
[21:01:25.204] Received PubSub notification, asking Buildbucket for the build status
[21:01:25.229] Build:
{
"id": "8702643067183053633",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "mac-official"
},
"number": 412,
"createdBy": "project:chromium-m140",
"createTime": "2025-09-26T18:04:04.184803397Z",
"startTime": "2025-09-26T18:04:13.198059768Z",
"endTime": "2025-09-26T21:01:24.119063075Z",
"updateTime": "2025-09-26T21:01:24.119063075Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7d69780e1b1daf932203c1b6d36168eefb3ac511",
"ref": "refs/branch-heads/7339"
}
}
}
[21:01:25.229] Invocation finished in 2h57m22.351543442s with status SUCCEEDED