[23:31:43.022] New invocation is queued and will start shortly
[23:31:44.982] Starting the invocation (attempt 1)
[23:31:45.008] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34d5768f4ed2acc0d5949989dc93cd5c5881f217"
[23:31:45.008] Popped gitiles commit info from properties and tags
[23:31:45.008] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:31:45.008] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:31:45.009] Buildbucket request:
{
"requestId": "8843228945255744480",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "34d5768f4ed2acc0d5949989dc93cd5c5881f217",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8843228945255744480"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:31:45.643] Scheduled build:
{
"id": "8677798882398501153",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 41534,
"createdBy": "project:chromium",
"createTime": "2026-06-27T23:31:45.125303217Z",
"updateTime": "2026-06-27T23:31:45.125303217Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "34d5768f4ed2acc0d5949989dc93cd5c5881f217",
"ref": "refs/heads/main"
}
}
}
[23:31:45.643] Task URL: https://cr-buildbucket.appspot.com/build/8677798882398501153
[23:31:45.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:2:0) after 2m37s
[23:31:46.577] Received PubSub notification, asking Buildbucket for the build status
[23:31:46.598] Build status: SCHEDULED
[23:31:49.632] Received PubSub notification, asking Buildbucket for the build status
[23:31:49.649] Build status: STARTED
[23:34:22.659] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:2:0)
[23:34:22.675] Build status: STARTED
[23:34:22.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:5:0) after 5m3s
[23:39:25.688] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:5:0)
[23:39:25.706] Build status: STARTED
[23:39:25.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:6:0) after 2m8s
[23:41:33.684] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:6:0)
[23:41:33.700] Build status: STARTED
[23:41:33.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:7:0) after 9m26s
[23:51:00.012] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:7:0)
[23:51:00.046] Build status: STARTED
[23:51:00.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:8:0) after 4m20s
[23:55:20.059] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:8:0)
[23:55:20.072] Build status: STARTED
[23:55:20.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:9:0) after 9m15s
[00:04:35.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:9:0)
[00:04:35.107] Build status: STARTED
[00:04:35.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:10:0) after 8m59s
[00:13:34.981] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:10:0)
[00:13:35.002] Build status: STARTED
[00:13:35.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:11:0) after 1m7s
[00:14:42.104] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:11:0)
[00:14:42.128] Build status: STARTED
[00:14:42.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:12:0) after 9m48s
[00:24:30.288] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:12:0)
[00:24:30.317] Build status: STARTED
[00:24:30.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:13:0) after 7m8s
[00:31:38.333] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:13:0)
[00:31:38.351] Build status: STARTED
[00:31:38.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:14:0) after 7m49s
[00:39:27.388] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:14:0)
[00:39:27.411] Build status: STARTED
[00:39:27.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:15:0) after 9m31s
[00:48:58.646] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:15:0)
[00:48:58.665] Build status: STARTED
[00:48:58.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:16:0) after 1m21s
[00:50:19.692] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:16:0)
[00:50:19.709] Build status: STARTED
[00:50:19.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:17:0) after 1m6s
[00:51:25.722] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:17:0)
[00:51:25.739] Build status: STARTED
[00:51:25.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:18:0) after 5m18s
[00:56:43.883] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:18:0)
[00:56:43.902] Build status: STARTED
[00:56:43.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:19:0) after 2m48s
[00:59:31.996] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:19:0)
[00:59:32.028] Build status: STARTED
[00:59:32.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:20:0) after 2m9s
[01:01:41.055] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:20:0)
[01:01:41.074] Build status: STARTED
[01:01:41.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:21:0) after 2m49s
[01:04:30.328] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:21:0)
[01:04:30.347] Build status: STARTED
[01:04:30.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:22:0) after 5m42s
[01:10:12.462] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:22:0)
[01:10:12.538] Build status: STARTED
[01:10:12.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:23:0) after 2m2s
[01:12:14.710] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:23:0)
[01:12:14.728] Build status: STARTED
[01:12:14.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:24:0) after 9m29s
[01:21:44.023] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:24:0)
[01:21:44.044] Build status: STARTED
[01:21:44.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:25:0) after 4m14s
[01:25:58.296] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:25:0)
[01:25:58.324] Build status: STARTED
[01:25:58.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:26:0) after 6m47s
[01:32:45.341] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:26:0)
[01:32:45.363] Build status: STARTED
[01:32:45.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:27:0) after 8m49s
[01:41:34.428] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:27:0)
[01:41:34.445] Build status: STARTED
[01:41:34.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:28:0) after 3m47s
[01:45:21.561] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:28:0)
[01:45:21.579] Build status: STARTED
[01:45:21.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:29:0) after 2m40s
[01:48:01.646] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:29:0)
[01:48:01.662] Build status: STARTED
[01:48:01.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:30:0) after 1m41s
[01:49:42.782] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:30:0)
[01:49:42.823] Build status: STARTED
[01:49:42.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:31:0) after 6m4s
[01:55:46.846] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:31:0)
[01:55:46.881] Build status: STARTED
[01:55:46.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:32:0) after 1m25s
[01:57:12.009] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:32:0)
[01:57:12.031] Build status: STARTED
[01:57:12.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:33:0) after 6m54s
[02:04:06.044] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:33:0)
[02:04:06.125] Build status: STARTED
[02:04:06.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:34:0) after 3m22s
[02:07:28.142] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:34:0)
[02:07:28.162] Build status: STARTED
[02:07:28.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:35:0) after 4m0s
[02:11:28.178] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:35:0)
[02:11:28.213] Build status: STARTED
[02:11:28.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:36:0) after 9m26s
[02:20:54.244] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:36:0)
[02:20:54.315] Build status: STARTED
[02:20:54.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:37:0) after 3m59s
[02:24:53.416] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:37:0)
[02:24:53.479] Build status: STARTED
[02:24:53.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:38:0) after 3m35s
[02:28:28.471] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:38:0)
[02:28:28.492] Build status: STARTED
[02:28:28.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:39:0) after 8m17s
[02:36:45.510] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:39:0)
[02:36:45.531] Build status: STARTED
[02:36:45.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:40:0) after 1m20s
[02:38:05.947] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:40:0)
[02:38:05.972] Build status: STARTED
[02:38:05.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:41:0) after 7m25s
[02:45:31.505] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:41:0)
[02:45:31.530] Build status: STARTED
[02:45:31.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:42:0) after 4m10s
[02:49:41.758] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:42:0)
[02:49:41.778] Build status: STARTED
[02:49:41.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:43:0) after 1m25s
[02:51:06.795] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:43:0)
[02:51:06.813] Build status: STARTED
[02:51:06.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:44:0) after 1m36s
[02:52:43.027] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:44:0)
[02:52:43.048] Build status: STARTED
[02:52:43.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:45:0) after 3m17s
[02:56:00.065] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:45:0)
[02:56:00.083] Build status: STARTED
[02:56:00.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:46:0) after 4m45s
[03:00:45.291] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:46:0)
[03:00:45.306] Build status: STARTED
[03:00:45.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:47:0) after 6m4s
[03:06:49.275] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:47:0)
[03:06:49.317] Build status: STARTED
[03:06:49.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:48:0) after 1m12s
[03:08:01.332] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:48:0)
[03:08:01.352] Build status: STARTED
[03:08:01.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:49:0) after 9m0s
[03:17:01.477] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:49:0)
[03:17:01.493] Build status: STARTED
[03:17:01.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:50:0) after 4m24s
[03:21:25.592] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:50:0)
[03:21:25.624] Build status: STARTED
[03:21:25.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:51:0) after 2m4s
[03:23:29.639] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:51:0)
[03:23:29.663] Build status: STARTED
[03:23:29.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:52:0) after 6m13s
[03:29:42.682] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:52:0)
[03:29:42.700] Build status: STARTED
[03:29:42.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:53:0) after 7m34s
[03:37:16.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:53:0)
[03:37:16.780] Build status: STARTED
[03:37:16.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:54:0) after 1m51s
[03:39:07.808] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:54:0)
[03:39:07.828] Build status: STARTED
[03:39:07.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:55:0) after 7m14s
[03:46:21.929] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:55:0)
[03:46:21.948] Build status: STARTED
[03:46:21.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:56:0) after 4m40s
[03:51:01.962] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:56:0)
[03:51:02.037] Build status: STARTED
[03:51:02.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:57:0) after 4m3s
[03:55:05.014] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:57:0)
[03:55:05.036] Build status: STARTED
[03:55:05.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:58:0) after 6m36s
[04:01:41.163] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:58:0)
[04:01:41.181] Build status: STARTED
[04:01:41.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:59:0) after 6m54s
[04:08:35.324] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:59:0)
[04:08:35.350] Build status: STARTED
[04:08:35.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:60:0) after 1m44s
[04:10:19.472] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:60:0)
[04:10:19.489] Build status: STARTED
[04:10:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:61:0) after 6m30s
[04:16:49.573] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:61:0)
[04:16:49.679] Build status: STARTED
[04:16:49.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:62:0) after 9m42s
[04:26:31.932] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:62:0)
[04:26:31.950] Build status: STARTED
[04:26:31.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:63:0) after 8m0s
[04:34:31.966] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:63:0)
[04:34:31.986] Build status: STARTED
[04:34:31.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:64:0) after 2m26s
[04:36:58.226] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:64:0)
[04:36:58.244] Build status: STARTED
[04:36:58.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:65:0) after 2m51s
[04:39:49.279] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:65:0)
[04:39:49.305] Build status: STARTED
[04:39:49.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:66:0) after 3m17s
[04:43:06.338] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:66:0)
[04:43:06.357] Build status: STARTED
[04:43:06.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:67:0) after 1m33s
[04:44:39.412] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:67:0)
[04:44:39.435] Build status: STARTED
[04:44:39.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:8843228945255744480:68:0) after 3m31s
[04:45:27.080] Received PubSub notification, asking Buildbucket for the build status
[04:45:27.097] Build:
{
"id": "8677798882398501153",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac"
},
"number": 41534,
"createdBy": "project:chromium",
"createTime": "2026-06-27T23:31:45.125303217Z",
"startTime": "2026-06-27T23:31:49.465877068Z",
"endTime": "2026-06-28T04:44:55.743562090Z",
"updateTime": "2026-06-28T04:44:55.743562090Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "34d5768f4ed2acc0d5949989dc93cd5c5881f217",
"ref": "refs/heads/main"
}
}
}
[04:45:27.097] Invocation finished in 5h13m44.080023624s with status SUCCEEDED