[22:26:02.877] New invocation is queued and will start shortly
[22:26:05.298] Starting the invocation (attempt 1)
[22:26:05.337] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f3adf0141db994ea274b31069a0d90981ec964eb"
[22:26:05.337] Popped gitiles commit info from properties and tags
[22:26:05.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:26:05.338] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:26:05.338] Buildbucket request:
{
"requestId": "8842145913199663488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacPGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f3adf0141db994ea274b31069a0d90981ec964eb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8842145913199663488"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMacPGO"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:26:06.062] Scheduled build:
{
"id": "8676715849866732001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacPGO"
},
"number": 3730,
"createdBy": "project:chromium",
"createTime": "2026-07-09T22:26:05.435431835Z",
"updateTime": "2026-07-09T22:26:05.435431835Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f3adf0141db994ea274b31069a0d90981ec964eb",
"ref": "refs/heads/main"
}
}
}
[22:26:06.062] Task URL: https://cr-buildbucket.appspot.com/build/8676715849866732001
[22:26:06.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:2:0) after 6m0s
[22:26:07.148] Received PubSub notification, asking Buildbucket for the build status
[22:26:07.163] Build status: SCHEDULED
[22:26:09.636] Received PubSub notification, asking Buildbucket for the build status
[22:26:09.673] Build status: STARTED
[22:32:06.108] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:2:0)
[22:32:06.137] Build status: STARTED
[22:32:06.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:5:0) after 6m12s
[22:38:18.218] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:5:0)
[22:38:18.244] Build status: STARTED
[22:38:18.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:6:0) after 8m21s
[22:46:39.265] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:6:0)
[22:46:39.297] Build status: STARTED
[22:46:39.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:7:0) after 3m33s
[22:50:12.313] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:7:0)
[22:50:12.348] Build status: STARTED
[22:50:12.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:8:0) after 4m17s
[22:54:29.373] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:8:0)
[22:54:29.417] Build status: STARTED
[22:54:29.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:9:0) after 7m50s
[23:02:19.568] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:9:0)
[23:02:19.589] Build status: STARTED
[23:02:19.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:10:0) after 1m26s
[23:03:45.657] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:10:0)
[23:03:45.680] Build status: STARTED
[23:03:45.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:11:0) after 3m34s
[23:07:19.773] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:11:0)
[23:07:19.836] Build status: STARTED
[23:07:19.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:12:0) after 6m7s
[23:13:26.852] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:12:0)
[23:13:26.877] Build status: STARTED
[23:13:26.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:13:0) after 8m41s
[23:22:07.919] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:13:0)
[23:22:07.941] Build status: STARTED
[23:22:07.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:14:0) after 8m46s
[23:30:53.994] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:14:0)
[23:30:54.011] Build status: STARTED
[23:30:54.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:15:0) after 2m29s
[23:33:23.007] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:15:0)
[23:33:23.147] Build status: STARTED
[23:33:23.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:16:0) after 7m35s
[23:40:58.276] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:16:0)
[23:40:58.299] Build status: STARTED
[23:40:58.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:17:0) after 1m58s
[23:42:56.293] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:17:0)
[23:42:56.317] Build status: STARTED
[23:42:56.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:18:0) after 4m36s
[23:47:32.426] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:18:0)
[23:47:32.443] Build status: STARTED
[23:47:32.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:19:0) after 7m43s
[23:55:15.555] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:19:0)
[23:55:15.576] Build status: STARTED
[23:55:15.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:20:0) after 4m18s
[23:59:33.587] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:20:0)
[23:59:33.605] Build status: STARTED
[23:59:33.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:21:0) after 5m13s
[00:04:46.638] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:21:0)
[00:04:46.667] Build status: STARTED
[00:04:46.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:22:0) after 8m6s
[00:12:52.750] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:22:0)
[00:12:52.770] Build status: STARTED
[00:12:52.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:23:0) after 2m43s
[00:15:35.793] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:23:0)
[00:15:35.819] Build status: STARTED
[00:15:35.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:24:0) after 6m46s
[00:22:21.900] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:24:0)
[00:22:21.925] Build status: STARTED
[00:22:21.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:25:0) after 6m4s
[00:28:25.946] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:25:0)
[00:28:25.967] Build status: STARTED
[00:28:25.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:26:0) after 2m11s
[00:30:36.988] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:26:0)
[00:30:37.022] Build status: STARTED
[00:30:37.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:27:0) after 9m27s
[00:40:04.096] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:27:0)
[00:40:04.135] Build status: STARTED
[00:40:04.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:28:0) after 9m23s
[00:49:27.185] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:28:0)
[00:49:27.252] Build status: STARTED
[00:49:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:29:0) after 4m9s
[00:53:36.312] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:29:0)
[00:53:36.332] Build status: STARTED
[00:53:36.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:30:0) after 4m12s
[00:57:48.399] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:30:0)
[00:57:48.436] Build status: STARTED
[00:57:48.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:31:0) after 3m35s
[01:01:23.540] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:31:0)
[01:01:23.565] Build status: STARTED
[01:01:23.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:32:0) after 1m38s
[01:03:01.587] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:32:0)
[01:03:01.605] Build status: STARTED
[01:03:01.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:33:0) after 4m3s
[01:07:04.660] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:33:0)
[01:07:04.679] Build status: STARTED
[01:07:04.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:34:0) after 2m34s
[01:09:38.653] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:34:0)
[01:09:38.675] Build status: STARTED
[01:09:38.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:35:0) after 1m44s
[01:11:22.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:35:0)
[01:11:22.751] Build status: STARTED
[01:11:22.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMacPGO:8842145913199663488:36:0) after 9m55s
[01:12:35.069] Received PubSub notification, asking Buildbucket for the build status
[01:12:35.092] Build:
{
"id": "8676715849866732001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMacPGO"
},
"number": 3730,
"createdBy": "project:chromium",
"createTime": "2026-07-09T22:26:05.435431835Z",
"startTime": "2026-07-09T22:26:09.355824965Z",
"endTime": "2026-07-10T01:12:34.801795953Z",
"updateTime": "2026-07-10T01:12:34.801795953Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f3adf0141db994ea274b31069a0d90981ec964eb",
"ref": "refs/heads/main"
}
}
}
[01:12:35.092] Invocation finished in 2h46m32.220758888s with status FAILED