[12:59:04.703] New invocation is queued and will start shortly
[12:59:05.766] Starting the invocation (attempt 1)
[12:59:05.789] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9f7e3a23620d6c5b8f658012b0742b0159d4039"
[12:59:05.789] Popped gitiles commit info from properties and tags
[12:59:05.789] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:59:05.789] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:59:05.789] Buildbucket request:
{
"requestId": "8864649631516508064",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e9f7e3a23620d6c5b8f658012b0742b0159d4039",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8864649631516508064"
},
{
"key": "scheduler_job_id",
"value": "chromium/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:59:06.297] Scheduled build:
{
"id": "8699219569665583793",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-official"
},
"number": 13118,
"createdBy": "project:chromium",
"createTime": "2025-11-03T12:59:05.839060932Z",
"updateTime": "2025-11-03T12:59:05.839060932Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e9f7e3a23620d6c5b8f658012b0742b0159d4039",
"ref": "refs/heads/main"
}
}
}
[12:59:06.297] Task URL: https://cr-buildbucket.appspot.com/build/8699219569665583793
[12:59:06.297] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:2:0) after 4m24s
[12:59:06.376] Received PubSub notification, asking Buildbucket for the build status
[12:59:06.397] Build status: SCHEDULED
[12:59:10.037] Received PubSub notification, asking Buildbucket for the build status
[12:59:10.074] Build status: STARTED
[13:03:30.291] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:2:0)
[13:03:30.312] Build status: STARTED
[13:03:30.312] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:5:0) after 7m9s
[13:10:39.413] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:5:0)
[13:10:39.446] Build status: STARTED
[13:10:39.446] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:6:0) after 1m21s
[13:12:00.501] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:6:0)
[13:12:00.518] Build status: STARTED
[13:12:00.518] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:7:0) after 4m32s
[13:16:32.534] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:7:0)
[13:16:32.549] Build status: STARTED
[13:16:32.549] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:8:0) after 4m58s
[13:21:30.561] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:8:0)
[13:21:30.588] Build status: STARTED
[13:21:30.588] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:9:0) after 2m27s
[13:23:58.883] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:9:0)
[13:23:58.924] Build status: STARTED
[13:23:58.924] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:10:0) after 6m8s
[13:30:06.942] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:10:0)
[13:30:06.968] Build status: STARTED
[13:30:06.968] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:11:0) after 1m3s
[13:31:10.036] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:11:0)
[13:31:10.105] Build status: STARTED
[13:31:10.106] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:12:0) after 8m4s
[13:39:14.132] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:12:0)
[13:39:14.152] Build status: STARTED
[13:39:14.152] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:13:0) after 1m3s
[13:40:17.176] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:13:0)
[13:40:17.192] Build status: STARTED
[13:40:17.192] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:14:0) after 4m21s
[13:44:38.206] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:14:0)
[13:44:38.228] Build status: STARTED
[13:44:38.228] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:15:0) after 8m18s
[13:52:56.247] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:15:0)
[13:52:56.268] Build status: STARTED
[13:52:56.268] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:16:0) after 4m5s
[13:57:01.288] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:16:0)
[13:57:01.343] Build status: STARTED
[13:57:01.343] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:17:0) after 9m24s
[14:06:25.386] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:17:0)
[14:06:25.403] Build status: STARTED
[14:06:25.403] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:18:0) after 7m44s
[14:14:09.459] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:18:0)
[14:14:09.485] Build status: STARTED
[14:14:09.485] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:19:0) after 2m10s
[14:16:19.503] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:19:0)
[14:16:19.518] Build status: STARTED
[14:16:19.518] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:20:0) after 5m36s
[14:21:55.582] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:20:0)
[14:21:55.602] Build status: STARTED
[14:21:55.603] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:21:0) after 3m34s
[14:25:29.653] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:21:0)
[14:25:29.673] Build status: STARTED
[14:25:29.674] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:22:0) after 8m23s
[14:33:52.690] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:22:0)
[14:33:52.708] Build status: STARTED
[14:33:52.708] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:23:0) after 5m37s
[14:39:29.728] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:23:0)
[14:39:29.744] Build status: STARTED
[14:39:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:24:0) after 9m38s
[14:49:08.038] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:24:0)
[14:49:08.053] Build status: STARTED
[14:49:08.053] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:25:0) after 2m9s
[14:51:17.082] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:25:0)
[14:51:17.103] Build status: STARTED
[14:51:17.103] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:26:0) after 9m44s
[15:01:01.091] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:26:0)
[15:01:01.118] Build status: STARTED
[15:01:01.118] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:27:0) after 6m2s
[15:07:03.279] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:27:0)
[15:07:03.307] Build status: STARTED
[15:07:03.307] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:28:0) after 9m42s
[15:16:45.376] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:28:0)
[15:16:45.440] Build status: STARTED
[15:16:45.440] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:29:0) after 7m19s
[15:24:04.507] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:29:0)
[15:24:04.530] Build status: STARTED
[15:24:04.530] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:30:0) after 6m28s
[15:30:32.565] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:30:0)
[15:30:32.674] Build status: STARTED
[15:30:32.674] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:31:0) after 7m38s
[15:38:10.741] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:31:0)
[15:38:10.827] Build status: STARTED
[15:38:10.827] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:32:0) after 4m13s
[15:42:23.847] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:32:0)
[15:42:23.865] Build status: STARTED
[15:42:23.865] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:33:0) after 1m41s
[15:44:05.495] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:33:0)
[15:44:05.527] Build status: STARTED
[15:44:05.527] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:34:0) after 1m3s
[15:45:08.543] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:34:0)
[15:45:08.559] Build status: STARTED
[15:45:08.559] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:35:0) after 9m2s
[15:54:10.576] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:35:0)
[15:54:10.593] Build status: STARTED
[15:54:10.593] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:36:0) after 7m54s
[16:02:04.637] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:36:0)
[16:02:04.664] Build status: STARTED
[16:02:04.664] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:37:0) after 4m47s
[16:06:51.684] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:37:0)
[16:06:51.713] Build status: STARTED
[16:06:51.713] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:38:0) after 3m38s
[16:10:29.745] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:38:0)
[16:10:29.761] Build status: STARTED
[16:10:29.761] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:39:0) after 1m4s
[16:11:33.831] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:39:0)
[16:11:33.846] Build status: STARTED
[16:11:33.846] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:40:0) after 6m3s
[16:17:36.874] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:40:0)
[16:17:36.915] Build status: STARTED
[16:17:36.915] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:41:0) after 5m59s
[16:23:35.981] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:41:0)
[16:23:35.998] Build status: STARTED
[16:23:35.998] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:42:0) after 3m21s
[16:26:57.012] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:42:0)
[16:26:57.030] Build status: STARTED
[16:26:57.030] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8864649631516508064:43:0) after 9m50s
[16:29:21.014] Received PubSub notification, asking Buildbucket for the build status
[16:29:21.068] Build:
{
"id": "8699219569665583793",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-official"
},
"number": 13118,
"createdBy": "project:chromium",
"createTime": "2025-11-03T12:59:05.839060932Z",
"startTime": "2025-11-03T12:59:09.870911278Z",
"endTime": "2025-11-03T16:29:20.425195087Z",
"updateTime": "2025-11-03T16:29:20.425195087Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e9f7e3a23620d6c5b8f658012b0742b0159d4039",
"ref": "refs/heads/main"
}
}
}
[16:29:21.068] Invocation finished in 3h30m16.377917257s with status SUCCEEDED