[21:15:20.820] New invocation is queued and will start shortly
[21:15:22.213] Starting the invocation (attempt 1)
[21:15:22.243] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/81ca3f9f457a6deafde440190dc3e8ecc5c762e5"
[21:15:22.243] Popped gitiles commit info from properties and tags
[21:15:22.243] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:15:22.243] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:15:22.244] Buildbucket request:
{
"requestId": "8872500345068128048",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872500345068128048",
"job": "chromium-m140/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1b830f9fc20e26f6f597972b0451b58a1cac548b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@1b830f9fc20e26f6f597972b0451b58a1cac548b",
"title": "1b830f9fc20e26f6f597972b0451b58a1cac548b",
"url": "https://chromium.googlesource.com/chromium/src/+/1b830f9fc20e26f6f597972b0451b58a1cac548b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4a1cb893a5e4172b9e33d223d240feb8e9c80a7b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@4a1cb893a5e4172b9e33d223d240feb8e9c80a7b",
"title": "4a1cb893a5e4172b9e33d223d240feb8e9c80a7b",
"url": "https://chromium.googlesource.com/chromium/src/+/4a1cb893a5e4172b9e33d223d240feb8e9c80a7b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bafa4d3b3a09c5df1eaca52c1aa1c903d13a558e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@bafa4d3b3a09c5df1eaca52c1aa1c903d13a558e",
"title": "bafa4d3b3a09c5df1eaca52c1aa1c903d13a558e",
"url": "https://chromium.googlesource.com/chromium/src/+/bafa4d3b3a09c5df1eaca52c1aa1c903d13a558e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "819c071f39f04764fc81e98933d06c3447d05392"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@819c071f39f04764fc81e98933d06c3447d05392",
"title": "819c071f39f04764fc81e98933d06c3447d05392",
"url": "https://chromium.googlesource.com/chromium/src/+/819c071f39f04764fc81e98933d06c3447d05392"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "56dfad1a7d991b21b01a3a9cb3373da1f960fec2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@56dfad1a7d991b21b01a3a9cb3373da1f960fec2",
"title": "56dfad1a7d991b21b01a3a9cb3373da1f960fec2",
"url": "https://chromium.googlesource.com/chromium/src/+/56dfad1a7d991b21b01a3a9cb3373da1f960fec2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "63d185dd415a690fbca9f34f9f9f0e1c6223efba"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@63d185dd415a690fbca9f34f9f9f0e1c6223efba",
"title": "63d185dd415a690fbca9f34f9f9f0e1c6223efba",
"url": "https://chromium.googlesource.com/chromium/src/+/63d185dd415a690fbca9f34f9f9f0e1c6223efba"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c8ba9232bf7696b613478f1eadf6a66b5ed2580a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@c8ba9232bf7696b613478f1eadf6a66b5ed2580a",
"title": "c8ba9232bf7696b613478f1eadf6a66b5ed2580a",
"url": "https://chromium.googlesource.com/chromium/src/+/c8ba9232bf7696b613478f1eadf6a66b5ed2580a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b331671e535b2a4910fbd11c934ee6aa1daeabb0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@b331671e535b2a4910fbd11c934ee6aa1daeabb0",
"title": "b331671e535b2a4910fbd11c934ee6aa1daeabb0",
"url": "https://chromium.googlesource.com/chromium/src/+/b331671e535b2a4910fbd11c934ee6aa1daeabb0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c0c0ad627baf264a97351a782ff25d006ed1f1ca"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@c0c0ad627baf264a97351a782ff25d006ed1f1ca",
"title": "c0c0ad627baf264a97351a782ff25d006ed1f1ca",
"url": "https://chromium.googlesource.com/chromium/src/+/c0c0ad627baf264a97351a782ff25d006ed1f1ca"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c040868aacce2b2a0545e7ad6d1c3a75b9ccf91a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@c040868aacce2b2a0545e7ad6d1c3a75b9ccf91a",
"title": "c040868aacce2b2a0545e7ad6d1c3a75b9ccf91a",
"url": "https://chromium.googlesource.com/chromium/src/+/c040868aacce2b2a0545e7ad6d1c3a75b9ccf91a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2e874b611faa63496c8b53ca6c4bca2e010d08b5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@2e874b611faa63496c8b53ca6c4bca2e010d08b5",
"title": "2e874b611faa63496c8b53ca6c4bca2e010d08b5",
"url": "https://chromium.googlesource.com/chromium/src/+/2e874b611faa63496c8b53ca6c4bca2e010d08b5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c6abded9d6c70f264cb44b0f11f9794cd6a5787c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@c6abded9d6c70f264cb44b0f11f9794cd6a5787c",
"title": "c6abded9d6c70f264cb44b0f11f9794cd6a5787c",
"url": "https://chromium.googlesource.com/chromium/src/+/c6abded9d6c70f264cb44b0f11f9794cd6a5787c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "21f4f223b24fc60082919188de0217ae86f348dd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@21f4f223b24fc60082919188de0217ae86f348dd",
"title": "21f4f223b24fc60082919188de0217ae86f348dd",
"url": "https://chromium.googlesource.com/chromium/src/+/21f4f223b24fc60082919188de0217ae86f348dd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4b19975910a362e50e8f53c279906f69f334d5c1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@4b19975910a362e50e8f53c279906f69f334d5c1",
"title": "4b19975910a362e50e8f53c279906f69f334d5c1",
"url": "https://chromium.googlesource.com/chromium/src/+/4b19975910a362e50e8f53c279906f69f334d5c1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a330e5ac12c0cb7578beb8ff986df02a40feea6d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@a330e5ac12c0cb7578beb8ff986df02a40feea6d",
"title": "a330e5ac12c0cb7578beb8ff986df02a40feea6d",
"url": "https://chromium.googlesource.com/chromium/src/+/a330e5ac12c0cb7578beb8ff986df02a40feea6d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "df63053ab14d6d607e998cefc695c34f36db7abc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@df63053ab14d6d607e998cefc695c34f36db7abc",
"title": "df63053ab14d6d607e998cefc695c34f36db7abc",
"url": "https://chromium.googlesource.com/chromium/src/+/df63053ab14d6d607e998cefc695c34f36db7abc"
},
{
"gitiles": {
"ref": "refs/branch-heads/7339",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "81ca3f9f457a6deafde440190dc3e8ecc5c762e5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7339@81ca3f9f457a6deafde440190dc3e8ecc5c762e5",
"title": "81ca3f9f457a6deafde440190dc3e8ecc5c762e5",
"url": "https://chromium.googlesource.com/chromium/src/+/81ca3f9f457a6deafde440190dc3e8ecc5c762e5"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "81ca3f9f457a6deafde440190dc3e8ecc5c762e5",
"ref": "refs/branch-heads/7339"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872500345068128048"
},
{
"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"
}
}
[21:15:22.854] Scheduled build:
{
"id": "8707070282860274561",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "mac-official"
},
"number": 28,
"createdBy": "project:chromium-m140",
"createTime": "2025-08-08T21:15:22.300581757Z",
"updateTime": "2025-08-08T21:15:22.300581757Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "81ca3f9f457a6deafde440190dc3e8ecc5c762e5",
"ref": "refs/branch-heads/7339"
}
}
}
[21:15:22.854] Task URL: https://cr-buildbucket.appspot.com/build/8707070282860274561
[21:15:22.854] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:2:0) after 3m15s
[21:15:22.948] Received PubSub notification, asking Buildbucket for the build status
[21:15:23.017] Build status: SCHEDULED
[21:15:29.724] Received PubSub notification, asking Buildbucket for the build status
[21:15:29.763] Build status: STARTED
[21:18:37.872] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:2:0)
[21:18:37.903] Build status: STARTED
[21:18:37.903] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:5:0) after 2m19s
[21:20:56.941] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:5:0)
[21:20:56.963] Build status: STARTED
[21:20:56.963] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:6:0) after 8m47s
[21:29:44.008] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:6:0)
[21:29:44.037] Build status: STARTED
[21:29:44.037] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:7:0) after 6m55s
[21:36:39.040] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:7:0)
[21:36:39.063] Build status: STARTED
[21:36:39.064] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:8:0) after 6m5s
[21:42:44.045] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:8:0)
[21:42:44.062] Build status: STARTED
[21:42:44.062] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:9:0) after 1m24s
[21:44:08.087] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:9:0)
[21:44:08.112] Build status: STARTED
[21:44:08.112] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:10:0) after 4m18s
[21:48:26.136] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:10:0)
[21:48:26.162] Build status: STARTED
[21:48:26.162] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:11:0) after 2m52s
[21:51:18.183] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:11:0)
[21:51:18.316] Build status: STARTED
[21:51:18.316] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:12:0) after 2m10s
[21:53:28.366] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:12:0)
[21:53:28.382] Build status: STARTED
[21:53:28.382] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:13:0) after 5m35s
[21:59:03.474] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:13:0)
[21:59:03.497] Build status: STARTED
[21:59:03.497] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:14:0) after 5m43s
[22:04:46.513] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:14:0)
[22:04:46.540] Build status: STARTED
[22:04:46.540] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:15:0) after 1m41s
[22:06:27.553] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:15:0)
[22:06:27.576] Build status: STARTED
[22:06:27.576] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:16:0) after 8m13s
[22:14:40.593] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:16:0)
[22:14:40.613] Build status: STARTED
[22:14:40.613] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:17:0) after 4m44s
[22:19:24.629] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:17:0)
[22:19:24.749] Build status: STARTED
[22:19:24.749] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:18:0) after 1m27s
[22:20:51.732] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:18:0)
[22:20:51.794] Build status: STARTED
[22:20:51.794] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:19:0) after 7m59s
[22:28:50.812] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:19:0)
[22:28:50.831] Build status: STARTED
[22:28:50.831] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:20:0) after 9m53s
[22:38:43.912] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:20:0)
[22:38:43.926] Build status: STARTED
[22:38:43.926] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:21:0) after 4m52s
[22:43:35.990] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:21:0)
[22:43:36.013] Build status: STARTED
[22:43:36.013] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:22:0) after 4m45s
[22:48:21.077] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:22:0)
[22:48:21.095] Build status: STARTED
[22:48:21.095] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:23:0) after 5m38s
[22:53:59.177] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:23:0)
[22:53:59.194] Build status: STARTED
[22:53:59.194] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:24:0) after 5m55s
[22:59:54.258] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:24:0)
[22:59:54.282] Build status: STARTED
[22:59:54.282] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:25:0) after 6m10s
[23:06:04.369] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:25:0)
[23:06:04.397] Build status: STARTED
[23:06:04.397] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:26:0) after 3m5s
[23:09:09.418] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:26:0)
[23:09:09.524] Build status: STARTED
[23:09:09.524] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:27:0) after 1m24s
[23:10:33.539] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:27:0)
[23:10:33.559] Build status: STARTED
[23:10:33.559] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:28:0) after 9m26s
[23:19:59.579] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:28:0)
[23:19:59.601] Build status: STARTED
[23:19:59.601] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:29:0) after 6m45s
[23:26:44.657] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:29:0)
[23:26:44.674] Build status: STARTED
[23:26:44.674] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:30:0) after 9m43s
[23:36:27.668] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:30:0)
[23:36:27.687] Build status: STARTED
[23:36:27.687] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:31:0) after 9m16s
[23:45:43.703] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:31:0)
[23:45:43.724] Build status: STARTED
[23:45:43.725] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:32:0) after 6m6s
[23:51:49.739] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:32:0)
[23:51:49.766] Build status: STARTED
[23:51:49.766] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:33:0) after 4m28s
[23:56:17.834] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:33:0)
[23:56:17.862] Build status: STARTED
[23:56:17.862] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:34:0) after 6m54s
[00:03:11.968] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:34:0)
[00:03:12.027] Build status: STARTED
[00:03:12.027] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:35:0) after 5m1s
[00:08:13.137] Handling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:35:0)
[00:08:13.152] Build status: STARTED
[00:08:13.152] Scheduling timer "check-buildbucket-build-status" (chromium-m140/mac-official:8872500345068128048:36:0) after 9m52s
[00:17:50.771] Received PubSub notification, asking Buildbucket for the build status
[00:17:50.862] Build:
{
"id": "8707070282860274561",
"builder": {
"project": "chromium-m140",
"bucket": "ci",
"builder": "mac-official"
},
"number": 28,
"createdBy": "project:chromium-m140",
"createTime": "2025-08-08T21:15:22.300581757Z",
"startTime": "2025-08-08T21:15:29.357181274Z",
"endTime": "2025-08-09T00:17:50.357215213Z",
"updateTime": "2025-08-09T00:17:50.357215213Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "81ca3f9f457a6deafde440190dc3e8ecc5c762e5",
"ref": "refs/branch-heads/7339"
}
}
}
[00:17:50.862] Invocation finished in 3h2m30.052957405s with status SUCCEEDED