[18:56:14.218] New invocation is queued and will start shortly
[18:56:15.308] Starting the invocation (attempt 1)
[18:56:15.338] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8ee9afc4e015b4f14ed0040402e5df6a5ffe8a2e"
[18:56:15.338] Popped gitiles commit info from properties and tags
[18:56:15.338] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:56:15.338] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:56:15.339] Buildbucket request:
{
"requestId": "8851581197878258096",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Mac deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8ee9afc4e015b4f14ed0040402e5df6a5ffe8a2e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851581197878258096"
},
{
"key": "scheduler_job_id",
"value": "chromium/Mac deterministic"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:56:15.854] Scheduled build:
{
"id": "8686151135981412945",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Mac deterministic"
},
"number": 76194,
"createdBy": "project:chromium",
"createTime": "2026-03-27T18:56:15.399264705Z",
"updateTime": "2026-03-27T18:56:15.399264705Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8ee9afc4e015b4f14ed0040402e5df6a5ffe8a2e",
"ref": "refs/heads/main"
}
}
}
[18:56:15.854] Task URL: https://cr-buildbucket.appspot.com/build/8686151135981412945
[18:56:15.854] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:2:0) after 4m56s
[18:56:16.778] Received PubSub notification, asking Buildbucket for the build status
[18:56:16.797] Build status: SCHEDULED
[18:56:21.621] Received PubSub notification, asking Buildbucket for the build status
[18:56:21.693] Build status: STARTED
[19:01:11.979] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:2:0)
[19:01:11.999] Build status: STARTED
[19:01:11.999] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:5:0) after 4m28s
[19:05:40.105] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:5:0)
[19:05:40.126] Build status: STARTED
[19:05:40.126] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:6:0) after 6m32s
[19:12:12.149] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:6:0)
[19:12:12.214] Build status: STARTED
[19:12:12.214] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:7:0) after 2m57s
[19:15:09.231] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:7:0)
[19:15:09.249] Build status: STARTED
[19:15:09.249] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:8:0) after 3m55s
[19:19:04.446] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:8:0)
[19:19:04.464] Build status: STARTED
[19:19:04.464] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:9:0) after 1m23s
[19:20:27.484] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:9:0)
[19:20:27.511] Build status: STARTED
[19:20:27.511] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:10:0) after 7m6s
[19:27:33.609] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:10:0)
[19:27:33.677] Build status: STARTED
[19:27:33.677] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:11:0) after 4m30s
[19:32:03.694] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:11:0)
[19:32:03.731] Build status: STARTED
[19:32:03.731] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:12:0) after 7m35s
[19:39:38.776] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:12:0)
[19:39:38.821] Build status: STARTED
[19:39:38.821] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:13:0) after 4m5s
[19:43:43.898] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:13:0)
[19:43:43.915] Build status: STARTED
[19:43:43.915] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:14:0) after 3m22s
[19:47:05.938] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:14:0)
[19:47:05.991] Build status: STARTED
[19:47:05.991] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:15:0) after 6m26s
[19:53:32.106] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:15:0)
[19:53:32.127] Build status: STARTED
[19:53:32.127] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:16:0) after 7m9s
[20:00:41.198] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:16:0)
[20:00:41.228] Build status: STARTED
[20:00:41.228] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:17:0) after 7m42s
[20:08:23.363] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:17:0)
[20:08:23.380] Build status: STARTED
[20:08:23.380] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:18:0) after 8m2s
[20:16:25.427] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:18:0)
[20:16:25.480] Build status: STARTED
[20:16:25.480] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:19:0) after 2m32s
[20:18:57.553] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:19:0)
[20:18:57.569] Build status: STARTED
[20:18:57.569] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:20:0) after 1m39s
[20:20:36.687] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:20:0)
[20:20:36.702] Build status: STARTED
[20:20:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:21:0) after 4m33s
[20:25:09.779] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:21:0)
[20:25:09.794] Build status: STARTED
[20:25:09.794] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:22:0) after 3m13s
[20:28:22.912] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:22:0)
[20:28:22.930] Build status: STARTED
[20:28:22.930] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:23:0) after 3m8s
[20:31:30.990] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:23:0)
[20:31:31.007] Build status: STARTED
[20:31:31.007] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:24:0) after 8m50s
[20:40:21.067] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:24:0)
[20:40:21.093] Build status: STARTED
[20:40:21.093] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:25:0) after 8m21s
[20:48:42.110] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:25:0)
[20:48:42.130] Build status: STARTED
[20:48:42.130] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8851581197878258096:26:0) after 4m47s
[20:50:40.683] Received PubSub notification, asking Buildbucket for the build status
[20:50:40.702] Build:
{
"id": "8686151135981412945",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Mac deterministic"
},
"number": 76194,
"createdBy": "project:chromium",
"createTime": "2026-03-27T18:56:15.399264705Z",
"startTime": "2026-03-27T18:56:21.299163427Z",
"endTime": "2026-03-27T20:50:40.327295894Z",
"updateTime": "2026-03-27T20:50:40.327295894Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "8ee9afc4e015b4f14ed0040402e5df6a5ffe8a2e",
"ref": "refs/heads/main"
}
}
}
[20:50:40.702] Invocation finished in 1h54m26.494821169s with status SUCCEEDED