[04:40:25.284] New invocation is queued and will start shortly
[04:40:26.763] Starting the invocation (attempt 1)
[04:40:26.794] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6641daf28509a20737cc2b4c37c081c7bfb889c2"
[04:40:26.794] Popped gitiles commit info from properties and tags
[04:40:26.794] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:40:26.794] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:40:26.794] Buildbucket request:
{
"requestId": "8838498481004782416",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacArm64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6641daf28509a20737cc2b4c37c081c7bfb889c2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8838498481004782416"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMacArm64PGO"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:40:27.482] Scheduled build:
{
"id": "8673068418601450081",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacArm64PGO"
},
"number": 4556,
"createdBy": "project:chromium",
"createTime": "2026-08-19T04:40:26.953960420Z",
"updateTime": "2026-08-19T04:40:26.953960420Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6641daf28509a20737cc2b4c37c081c7bfb889c2",
"ref": "refs/heads/main"
}
}
}
[04:40:27.482] Task URL: https://cr-buildbucket.appspot.com/build/8673068418601450081
[04:40:27.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:2:0) after 8m17s
[04:40:28.399] Received PubSub notification, asking Buildbucket for the build status
[04:40:28.417] Build status: SCHEDULED
[04:40:34.587] Received PubSub notification, asking Buildbucket for the build status
[04:40:34.644] Build status: STARTED
[04:48:44.523] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:2:0)
[04:48:44.547] Build status: STARTED
[04:48:44.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:5:0) after 8m45s
[04:57:29.650] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:5:0)
[04:57:29.696] Build status: STARTED
[04:57:29.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:6:0) after 1m55s
[04:59:24.817] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:6:0)
[04:59:24.874] Build status: STARTED
[04:59:24.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:7:0) after 8m28s
[05:07:52.946] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:7:0)
[05:07:52.967] Build status: STARTED
[05:07:52.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:8:0) after 4m42s
[05:12:35.032] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:8:0)
[05:12:35.062] Build status: STARTED
[05:12:35.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:9:0) after 5m37s
[05:18:12.160] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:9:0)
[05:18:12.182] Build status: STARTED
[05:18:12.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:10:0) after 9m22s
[05:27:34.297] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:10:0)
[05:27:34.317] Build status: STARTED
[05:27:34.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:11:0) after 7m42s
[05:35:16.341] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:11:0)
[05:35:16.405] Build status: STARTED
[05:35:16.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:12:0) after 6m2s
[05:41:18.528] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:12:0)
[05:41:18.554] Build status: STARTED
[05:41:18.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:13:0) after 8m34s
[05:49:52.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:13:0)
[05:49:52.841] Build status: STARTED
[05:49:52.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:14:0) after 5m3s
[05:54:55.879] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:14:0)
[05:54:55.905] Build status: STARTED
[05:54:55.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:15:0) after 6m13s
[06:01:09.059] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:15:0)
[06:01:09.144] Build status: STARTED
[06:01:09.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:16:0) after 8m59s
[06:10:08.228] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:16:0)
[06:10:08.265] Build status: STARTED
[06:10:08.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:17:0) after 7m28s
[06:17:36.286] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:17:0)
[06:17:36.319] Build status: STARTED
[06:17:36.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:18:0) after 7m49s
[06:25:25.558] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:18:0)
[06:25:25.577] Build status: STARTED
[06:25:25.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:19:0) after 4m43s
[06:30:08.698] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:19:0)
[06:30:08.719] Build status: STARTED
[06:30:08.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:20:0) after 8m25s
[06:38:33.714] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:20:0)
[06:38:33.737] Build status: STARTED
[06:38:33.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:21:0) after 1m11s
[06:39:44.757] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:21:0)
[06:39:44.806] Build status: STARTED
[06:39:44.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:22:0) after 7m6s
[06:46:50.841] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:22:0)
[06:46:50.863] Build status: STARTED
[06:46:50.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:23:0) after 4m50s
[06:51:40.897] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:23:0)
[06:51:40.917] Build status: STARTED
[06:51:40.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:24:0) after 5m51s
[06:57:32.045] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:24:0)
[06:57:32.065] Build status: STARTED
[06:57:32.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:25:0) after 1m56s
[06:59:28.125] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:25:0)
[06:59:28.141] Build status: STARTED
[06:59:28.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:26:0) after 2m43s
[07:02:11.261] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:26:0)
[07:02:11.289] Build status: STARTED
[07:02:11.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:27:0) after 5m39s
[07:07:50.308] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:27:0)
[07:07:50.326] Build status: STARTED
[07:07:50.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:28:0) after 7m58s
[07:15:48.384] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:28:0)
[07:15:48.465] Build status: STARTED
[07:15:48.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:29:0) after 7m22s
[07:23:10.650] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:29:0)
[07:23:10.726] Build status: STARTED
[07:23:10.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:30:0) after 2m9s
[07:25:19.806] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:30:0)
[07:25:19.831] Build status: STARTED
[07:25:19.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:31:0) after 5m55s
[07:31:14.946] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:31:0)
[07:31:14.968] Build status: STARTED
[07:31:14.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:32:0) after 5m28s
[07:36:43.043] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:32:0)
[07:36:43.072] Build status: STARTED
[07:36:43.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:33:0) after 6m23s
[07:43:06.134] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:33:0)
[07:43:06.155] Build status: STARTED
[07:43:06.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:34:0) after 1m41s
[07:44:47.372] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:34:0)
[07:44:47.405] Build status: STARTED
[07:44:47.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:35:0) after 3m44s
[07:48:31.469] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:35:0)
[07:48:31.496] Build status: STARTED
[07:48:31.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:36:0) after 5m27s
[07:53:58.549] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:36:0)
[07:53:58.568] Build status: STARTED
[07:53:58.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:37:0) after 6m59s
[08:00:57.692] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:37:0)
[08:00:57.722] Build status: STARTED
[08:00:57.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:38:0) after 1m53s
[08:02:50.791] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:38:0)
[08:02:50.810] Build status: STARTED
[08:02:50.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:39:0) after 3m4s
[08:05:54.939] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:39:0)
[08:05:54.990] Build status: STARTED
[08:05:54.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:40:0) after 5m35s
[08:11:30.078] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:40:0)
[08:11:30.096] Build status: STARTED
[08:11:30.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:41:0) after 3m36s
[08:15:06.204] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:41:0)
[08:15:06.228] Build status: STARTED
[08:15:06.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:42:0) after 5m55s
[08:21:01.299] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:42:0)
[08:21:01.398] Build status: STARTED
[08:21:01.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:43:0) after 2m44s
[08:23:45.474] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:43:0)
[08:23:45.496] Build status: STARTED
[08:23:45.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:44:0) after 7m59s
[08:31:44.593] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:44:0)
[08:31:44.614] Build status: STARTED
[08:31:44.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:45:0) after 9m34s
[08:41:18.711] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:45:0)
[08:41:18.732] Build status: STARTED
[08:41:18.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:46:0) after 3m50s
[08:45:08.752] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:46:0)
[08:45:08.781] Build status: STARTED
[08:45:08.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:47:0) after 3m0s
[08:48:08.873] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:47:0)
[08:48:08.894] Build status: STARTED
[08:48:08.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:48:0) after 6m11s
[08:54:19.923] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:48:0)
[08:54:19.944] Build status: STARTED
[08:54:19.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:49:0) after 2m0s
[08:56:20.095] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:49:0)
[08:56:20.117] Build status: STARTED
[08:56:20.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:50:0) after 8m58s
[09:05:18.161] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:50:0)
[09:05:18.179] Build status: STARTED
[09:05:18.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:51:0) after 2m32s
[09:07:50.298] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:51:0)
[09:07:50.318] Build status: STARTED
[09:07:50.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:52:0) after 9m57s
[09:17:47.391] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:52:0)
[09:17:47.416] Build status: STARTED
[09:17:47.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:53:0) after 3m10s
[09:20:57.435] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:53:0)
[09:20:57.459] Build status: STARTED
[09:20:57.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:54:0) after 4m30s
[09:25:27.580] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:54:0)
[09:25:27.597] Build status: STARTED
[09:25:27.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:55:0) after 1m6s
[09:26:33.620] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:55:0)
[09:26:33.650] Build status: STARTED
[09:26:33.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:56:0) after 3m18s
[09:29:51.672] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:56:0)
[09:29:51.693] Build status: STARTED
[09:29:51.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:57:0) after 8m39s
[09:38:30.726] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:57:0)
[09:38:30.748] Build status: STARTED
[09:38:30.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:58:0) after 7m33s
[09:46:03.767] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:58:0)
[09:46:03.789] Build status: STARTED
[09:46:03.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:59:0) after 1m51s
[09:47:54.819] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:59:0)
[09:47:54.845] Build status: STARTED
[09:47:54.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:60:0) after 3m46s
[09:51:40.889] Handling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:60:0)
[09:51:40.941] Build status: STARTED
[09:51:40.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacArm64PGO:8838498481004782416:61:0) after 8m44s
[09:53:13.743] Received PubSub notification, asking Buildbucket for the build status
[09:53:13.763] Build:
{
"id": "8673068418601450081",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacArm64PGO"
},
"number": 4556,
"createdBy": "project:chromium",
"createTime": "2026-08-19T04:40:26.953960420Z",
"startTime": "2026-08-19T04:40:34.420186732Z",
"endTime": "2026-08-19T09:53:13.305829249Z",
"updateTime": "2026-08-19T09:53:13.305829249Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6641daf28509a20737cc2b4c37c081c7bfb889c2",
"ref": "refs/heads/main"
}
}
}
[09:53:13.763] Invocation finished in 5h12m48.485291403s with status SUCCEEDED