[02:31:30.896] New invocation is queued and will start shortly
[02:31:31.929] Starting the invocation (attempt 1)
[02:31:31.956] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/99f2f7b7147e38e12680e255960996b75adf604d"
[02:31:31.956] Popped gitiles commit info from properties and tags
[02:31:31.956] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:31:31.957] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:31:31.957] Buildbucket request:
{
"requestId": "8884439253068894000",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_mac_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8884439253068894000",
"job": "openscreen/chromium_mac_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "341418084cd451e180b67239ee19cb062a6a84fb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@341418084cd451e180b67239ee19cb062a6a84fb",
"title": "341418084cd451e180b67239ee19cb062a6a84fb",
"url": "https://chromium.googlesource.com/chromium/src/+/341418084cd451e180b67239ee19cb062a6a84fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e42169bd6bb95ea2aa5d3d46ba423b0fa0abe4d0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e42169bd6bb95ea2aa5d3d46ba423b0fa0abe4d0",
"title": "e42169bd6bb95ea2aa5d3d46ba423b0fa0abe4d0",
"url": "https://chromium.googlesource.com/chromium/src/+/e42169bd6bb95ea2aa5d3d46ba423b0fa0abe4d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6e922fd986bfca654c0cddb3511fdc63f4bc599d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@6e922fd986bfca654c0cddb3511fdc63f4bc599d",
"title": "6e922fd986bfca654c0cddb3511fdc63f4bc599d",
"url": "https://chromium.googlesource.com/chromium/src/+/6e922fd986bfca654c0cddb3511fdc63f4bc599d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c5ac07c37dc9176627b2bce5bbcf3f4ce80de937"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c5ac07c37dc9176627b2bce5bbcf3f4ce80de937",
"title": "c5ac07c37dc9176627b2bce5bbcf3f4ce80de937",
"url": "https://chromium.googlesource.com/chromium/src/+/c5ac07c37dc9176627b2bce5bbcf3f4ce80de937"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d4ee3e0083acb49acdb4e4df4bfe4a474fc2a099"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d4ee3e0083acb49acdb4e4df4bfe4a474fc2a099",
"title": "d4ee3e0083acb49acdb4e4df4bfe4a474fc2a099",
"url": "https://chromium.googlesource.com/chromium/src/+/d4ee3e0083acb49acdb4e4df4bfe4a474fc2a099"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a1b23d2305f6de295a6393b41410b6b1196cc14b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a1b23d2305f6de295a6393b41410b6b1196cc14b",
"title": "a1b23d2305f6de295a6393b41410b6b1196cc14b",
"url": "https://chromium.googlesource.com/chromium/src/+/a1b23d2305f6de295a6393b41410b6b1196cc14b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "15641dafd7815d17ea797c6fafb07851f8ebb02d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@15641dafd7815d17ea797c6fafb07851f8ebb02d",
"title": "15641dafd7815d17ea797c6fafb07851f8ebb02d",
"url": "https://chromium.googlesource.com/chromium/src/+/15641dafd7815d17ea797c6fafb07851f8ebb02d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2ad115a6dec091a455f40fe9946544a3ee0f2d72"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2ad115a6dec091a455f40fe9946544a3ee0f2d72",
"title": "2ad115a6dec091a455f40fe9946544a3ee0f2d72",
"url": "https://chromium.googlesource.com/chromium/src/+/2ad115a6dec091a455f40fe9946544a3ee0f2d72"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "54e7750d83ce67d800f4af182190bfd76a834b0b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@54e7750d83ce67d800f4af182190bfd76a834b0b",
"title": "54e7750d83ce67d800f4af182190bfd76a834b0b",
"url": "https://chromium.googlesource.com/chromium/src/+/54e7750d83ce67d800f4af182190bfd76a834b0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9844e12ac639c28c7181dc0e99198843de244bfa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@9844e12ac639c28c7181dc0e99198843de244bfa",
"title": "9844e12ac639c28c7181dc0e99198843de244bfa",
"url": "https://chromium.googlesource.com/chromium/src/+/9844e12ac639c28c7181dc0e99198843de244bfa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "99f2f7b7147e38e12680e255960996b75adf604d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@99f2f7b7147e38e12680e255960996b75adf604d",
"title": "99f2f7b7147e38e12680e255960996b75adf604d",
"url": "https://chromium.googlesource.com/chromium/src/+/99f2f7b7147e38e12680e255960996b75adf604d"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99f2f7b7147e38e12680e255960996b75adf604d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884439253068894000"
},
{
"key": "scheduler_job_id",
"value": "openscreen/chromium_mac_x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:31:32.469] Scheduled build:
{
"id": "8719009191228340353",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_mac_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-03-30T02:31:32.023940460Z",
"updateTime": "2025-03-30T02:31:32.023940460Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99f2f7b7147e38e12680e255960996b75adf604d",
"ref": "refs/heads/main"
}
}
}
[02:31:32.469] Task URL: https://cr-buildbucket.appspot.com/build/8719009191228340353
[02:31:32.469] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:2:0) after 8m17s
[02:31:32.730] Received PubSub notification, asking Buildbucket for the build status
[02:31:32.799] Build status: SCHEDULED
[02:31:36.889] Received PubSub notification, asking Buildbucket for the build status
[02:31:36.910] Build status: STARTED
[02:39:49.490] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:2:0)
[02:39:49.517] Build status: STARTED
[02:39:49.517] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:5:0) after 6m15s
[02:46:04.640] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:5:0)
[02:46:04.677] Build status: STARTED
[02:46:04.677] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:6:0) after 2m23s
[02:48:27.697] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:6:0)
[02:48:27.793] Build status: STARTED
[02:48:27.793] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:7:0) after 2m27s
[02:50:54.807] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:7:0)
[02:50:54.870] Build status: STARTED
[02:50:54.870] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:8:0) after 1m30s
[02:52:25.149] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:8:0)
[02:52:25.206] Build status: STARTED
[02:52:25.206] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:9:0) after 7m15s
[02:59:40.358] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:9:0)
[02:59:40.376] Build status: STARTED
[02:59:40.376] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:10:0) after 7m10s
[03:06:50.403] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:10:0)
[03:06:50.434] Build status: STARTED
[03:06:50.434] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:11:0) after 5m5s
[03:11:55.505] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:11:0)
[03:11:55.539] Build status: STARTED
[03:11:55.539] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:12:0) after 8m4s
[03:19:59.521] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:12:0)
[03:19:59.552] Build status: STARTED
[03:19:59.552] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:13:0) after 8m38s
[03:28:37.672] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:13:0)
[03:28:37.705] Build status: STARTED
[03:28:37.706] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:14:0) after 8m38s
[03:37:15.723] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:14:0)
[03:37:15.759] Build status: STARTED
[03:37:15.759] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:15:0) after 6m33s
[03:43:48.861] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:15:0)
[03:43:48.898] Build status: STARTED
[03:43:48.898] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:16:0) after 6m15s
[03:50:04.172] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:16:0)
[03:50:04.269] Build status: STARTED
[03:50:04.269] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:17:0) after 2m48s
[03:52:52.554] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:17:0)
[03:52:52.587] Build status: STARTED
[03:52:52.587] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:18:0) after 3m28s
[03:56:20.686] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:18:0)
[03:56:20.716] Build status: STARTED
[03:56:20.716] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:19:0) after 9m46s
[04:06:06.747] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:19:0)
[04:06:06.769] Build status: STARTED
[04:06:06.769] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:20:0) after 6m44s
[04:12:51.254] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:20:0)
[04:12:51.307] Build status: STARTED
[04:12:51.308] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:21:0) after 9m2s
[04:21:53.548] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:21:0)
[04:21:53.583] Build status: STARTED
[04:21:53.583] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:22:0) after 5m24s
[04:27:17.733] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:22:0)
[04:27:17.757] Build status: STARTED
[04:27:17.758] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:23:0) after 1m47s
[04:29:04.966] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:23:0)
[04:29:05.001] Build status: STARTED
[04:29:05.001] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:24:0) after 1m41s
[04:30:46.017] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:24:0)
[04:30:46.043] Build status: STARTED
[04:30:46.043] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:25:0) after 6m1s
[04:36:47.062] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:25:0)
[04:36:47.090] Build status: STARTED
[04:36:47.090] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:26:0) after 4m1s
[04:40:48.119] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:26:0)
[04:40:48.147] Build status: STARTED
[04:40:48.147] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:27:0) after 4m55s
[04:45:43.453] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:27:0)
[04:45:43.476] Build status: STARTED
[04:45:43.476] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:28:0) after 4m35s
[04:50:18.479] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:28:0)
[04:50:18.504] Build status: STARTED
[04:50:18.504] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:29:0) after 1m14s
[04:51:32.548] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:29:0)
[04:51:32.576] Build status: STARTED
[04:51:32.576] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:30:0) after 4m2s
[04:55:34.800] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:30:0)
[04:55:34.827] Build status: STARTED
[04:55:34.827] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:31:0) after 8m4s
[05:03:38.985] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:31:0)
[05:03:39.007] Build status: STARTED
[05:03:39.007] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:32:0) after 1m9s
[05:04:48.010] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:32:0)
[05:04:48.041] Build status: STARTED
[05:04:48.041] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:33:0) after 9m19s
[05:14:07.281] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:33:0)
[05:14:07.309] Build status: STARTED
[05:14:07.309] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:34:0) after 6m34s
[05:20:41.411] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:34:0)
[05:20:41.433] Build status: STARTED
[05:20:41.433] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:35:0) after 3m40s
[05:24:21.559] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:35:0)
[05:24:21.590] Build status: STARTED
[05:24:21.590] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_x64:8884439253068894000:36:0) after 9m27s
[05:32:55.792] Received PubSub notification, asking Buildbucket for the build status
[05:32:55.809] Build:
{
"id": "8719009191228340353",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_mac_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-03-30T02:31:32.023940460Z",
"startTime": "2025-03-30T02:31:36.697357268Z",
"endTime": "2025-03-30T05:32:55.539435170Z",
"updateTime": "2025-03-30T05:32:55.539435170Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99f2f7b7147e38e12680e255960996b75adf604d",
"ref": "refs/heads/main"
}
}
}
[05:32:55.809] Invocation finished in 3h1m24.924842054s with status FAILED