[03:33:30.330] New invocation is queued and will start shortly
[03:33:31.424] Starting the invocation (attempt 1)
[03:33:31.450] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fa80cdd4f1de20f960cc8d126d7a90433c6221cc"
[03:33:31.450] Popped gitiles commit info from properties and tags
[03:33:31.450] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:33:31.450] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:33:31.450] Buildbucket request:
{
"requestId": "8894038631397904048",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894038631397904048",
"job": "chromium-m132/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7e35c4e3ac0acc29f5affa8210caebc43ebbb0d2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@7e35c4e3ac0acc29f5affa8210caebc43ebbb0d2",
"title": "7e35c4e3ac0acc29f5affa8210caebc43ebbb0d2",
"url": "https://chromium.googlesource.com/chromium/src/+/7e35c4e3ac0acc29f5affa8210caebc43ebbb0d2"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "50927b74b196b3f27bd25c07eab46a40676a77a3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@50927b74b196b3f27bd25c07eab46a40676a77a3",
"title": "50927b74b196b3f27bd25c07eab46a40676a77a3",
"url": "https://chromium.googlesource.com/chromium/src/+/50927b74b196b3f27bd25c07eab46a40676a77a3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d7bddb694301fd56bd92d6c8074e0859cfe1a2f0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@d7bddb694301fd56bd92d6c8074e0859cfe1a2f0",
"title": "d7bddb694301fd56bd92d6c8074e0859cfe1a2f0",
"url": "https://chromium.googlesource.com/chromium/src/+/d7bddb694301fd56bd92d6c8074e0859cfe1a2f0"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f752fe100535beb999f52b8327a83c8d86a9a695"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@f752fe100535beb999f52b8327a83c8d86a9a695",
"title": "f752fe100535beb999f52b8327a83c8d86a9a695",
"url": "https://chromium.googlesource.com/chromium/src/+/f752fe100535beb999f52b8327a83c8d86a9a695"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d33a8b257a48c048e1dee11153ca162ac684e364"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@d33a8b257a48c048e1dee11153ca162ac684e364",
"title": "d33a8b257a48c048e1dee11153ca162ac684e364",
"url": "https://chromium.googlesource.com/chromium/src/+/d33a8b257a48c048e1dee11153ca162ac684e364"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "51bd8cea043cf43adfa020b6a872ab4478ab3b39"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@51bd8cea043cf43adfa020b6a872ab4478ab3b39",
"title": "51bd8cea043cf43adfa020b6a872ab4478ab3b39",
"url": "https://chromium.googlesource.com/chromium/src/+/51bd8cea043cf43adfa020b6a872ab4478ab3b39"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "93b4265f6db716f3aef39ed691332991b09d9477"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@93b4265f6db716f3aef39ed691332991b09d9477",
"title": "93b4265f6db716f3aef39ed691332991b09d9477",
"url": "https://chromium.googlesource.com/chromium/src/+/93b4265f6db716f3aef39ed691332991b09d9477"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fa80cdd4f1de20f960cc8d126d7a90433c6221cc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@fa80cdd4f1de20f960cc8d126d7a90433c6221cc",
"title": "fa80cdd4f1de20f960cc8d126d7a90433c6221cc",
"url": "https://chromium.googlesource.com/chromium/src/+/fa80cdd4f1de20f960cc8d126d7a90433c6221cc"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fa80cdd4f1de20f960cc8d126d7a90433c6221cc",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894038631397904048"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:33:31.996] Scheduled build:
{
"id": "8728608569502070689",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "mac-official"
},
"number": 297,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-14T03:33:31.510172132Z",
"updateTime": "2024-12-14T03:33:31.510172132Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fa80cdd4f1de20f960cc8d126d7a90433c6221cc",
"ref": "refs/branch-heads/6834"
}
}
}
[03:33:31.996] Task URL: https://cr-buildbucket.appspot.com/build/8728608569502070689
[03:33:31.996] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:2:0) after 9m30s
[03:33:54.967] Received PubSub notification, asking Buildbucket for the build status
[03:33:55.051] Build status: STARTED
[03:33:57.000] Received PubSub notification, asking Buildbucket for the build status
[03:33:57.029] Build status: STARTED
[03:43:02.555] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:2:0)
[03:43:02.579] Build status: STARTED
[03:43:02.579] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:5:0) after 3m46s
[03:46:48.595] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:5:0)
[03:46:48.616] Build status: STARTED
[03:46:48.616] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:6:0) after 7m24s
[03:54:13.037] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:6:0)
[03:54:13.059] Build status: STARTED
[03:54:13.059] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:7:0) after 1m22s
[03:55:35.165] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:7:0)
[03:55:35.186] Build status: STARTED
[03:55:35.186] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:8:0) after 8m55s
[04:04:30.214] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:8:0)
[04:04:30.244] Build status: STARTED
[04:04:30.244] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:9:0) after 4m46s
[04:09:16.429] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:9:0)
[04:09:16.458] Build status: STARTED
[04:09:16.458] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:10:0) after 1m9s
[04:10:25.500] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:10:0)
[04:10:25.526] Build status: STARTED
[04:10:25.526] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:11:0) after 4m26s
[04:14:51.585] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:11:0)
[04:14:51.605] Build status: STARTED
[04:14:51.605] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:12:0) after 7m17s
[04:22:08.649] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:12:0)
[04:22:08.670] Build status: STARTED
[04:22:08.670] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:13:0) after 2m38s
[04:24:46.690] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:13:0)
[04:24:46.720] Build status: STARTED
[04:24:46.720] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:14:0) after 5m9s
[04:29:55.868] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:14:0)
[04:29:55.896] Build status: STARTED
[04:29:55.896] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:15:0) after 4m46s
[04:34:41.911] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:15:0)
[04:34:41.928] Build status: STARTED
[04:34:41.928] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:16:0) after 6m55s
[04:41:36.914] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:16:0)
[04:41:36.930] Build status: STARTED
[04:41:36.930] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:17:0) after 7m58s
[04:49:35.084] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:17:0)
[04:49:35.155] Build status: STARTED
[04:49:35.155] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:18:0) after 6m46s
[04:56:21.321] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:18:0)
[04:56:21.351] Build status: STARTED
[04:56:21.351] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:19:0) after 6m38s
[05:02:59.368] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:19:0)
[05:02:59.406] Build status: STARTED
[05:02:59.406] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:20:0) after 7m26s
[05:10:25.540] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:20:0)
[05:10:25.559] Build status: STARTED
[05:10:25.559] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:21:0) after 2m14s
[05:12:39.636] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:21:0)
[05:12:39.678] Build status: STARTED
[05:12:39.678] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:22:0) after 9m16s
[05:21:55.719] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:22:0)
[05:21:55.791] Build status: STARTED
[05:21:55.791] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:23:0) after 4m11s
[05:26:06.994] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:23:0)
[05:26:07.016] Build status: STARTED
[05:26:07.016] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:24:0) after 7m31s
[05:33:38.254] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:24:0)
[05:33:38.277] Build status: STARTED
[05:33:38.277] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:25:0) after 4m38s
[05:38:16.308] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:25:0)
[05:38:16.330] Build status: STARTED
[05:38:16.330] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:26:0) after 1m11s
[05:39:27.477] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:26:0)
[05:39:27.494] Build status: STARTED
[05:39:27.494] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:27:0) after 6m13s
[05:45:40.510] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:27:0)
[05:45:40.525] Build status: STARTED
[05:45:40.525] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:28:0) after 4m35s
[05:50:15.681] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:28:0)
[05:50:15.695] Build status: STARTED
[05:50:15.695] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:29:0) after 4m36s
[05:54:51.994] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:29:0)
[05:54:52.013] Build status: STARTED
[05:54:52.013] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:30:0) after 3m26s
[05:58:18.083] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:30:0)
[05:58:18.099] Build status: STARTED
[05:58:18.099] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:31:0) after 5m5s
[06:03:23.116] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:31:0)
[06:03:23.134] Build status: STARTED
[06:03:23.134] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:32:0) after 1m56s
[06:05:19.150] Handling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:32:0)
[06:05:19.166] Build status: STARTED
[06:05:19.166] Scheduling timer "check-buildbucket-build-status" (chromium-m132/mac-official:8894038631397904048:33:0) after 7m58s
[06:09:24.334] Received PubSub notification, asking Buildbucket for the build status
[06:09:24.353] Build:
{
"id": "8728608569502070689",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "mac-official"
},
"number": 297,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-14T03:33:31.510172132Z",
"startTime": "2024-12-14T03:33:36.746371338Z",
"endTime": "2024-12-14T06:09:22.746904738Z",
"updateTime": "2024-12-14T06:09:22.746904738Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fa80cdd4f1de20f960cc8d126d7a90433c6221cc",
"ref": "refs/branch-heads/6834"
}
}
}
[06:09:24.353] Invocation finished in 2h35m54.034778643s with status SUCCEEDED