[10:50:26.763] New invocation is queued and will start shortly
[10:50:28.102] Starting the invocation (attempt 1)
[10:50:28.133] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a"
[10:50:28.133] Popped gitiles commit info from properties and tags
[10:50:28.133] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:50:28.133] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:50:28.134] Buildbucket request:
{
"requestId": "8893739350575239776",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893739350575239776",
"job": "chromium-m131/linux-cast-x64-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "91edae81cb265e86b818c8e160c444fe8d1f7f15"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@91edae81cb265e86b818c8e160c444fe8d1f7f15",
"title": "91edae81cb265e86b818c8e160c444fe8d1f7f15",
"url": "https://chromium.googlesource.com/chromium/src/+/91edae81cb265e86b818c8e160c444fe8d1f7f15"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3a02d4f47236c45c4cb9be75746063cb324dadf3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@3a02d4f47236c45c4cb9be75746063cb324dadf3",
"title": "3a02d4f47236c45c4cb9be75746063cb324dadf3",
"url": "https://chromium.googlesource.com/chromium/src/+/3a02d4f47236c45c4cb9be75746063cb324dadf3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4cfc75c6042afd2682894af3229f180a3dab1589"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@4cfc75c6042afd2682894af3229f180a3dab1589",
"title": "4cfc75c6042afd2682894af3229f180a3dab1589",
"url": "https://chromium.googlesource.com/chromium/src/+/4cfc75c6042afd2682894af3229f180a3dab1589"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9bef2842301dcccff4d1a7d0681d167f387ff79c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@9bef2842301dcccff4d1a7d0681d167f387ff79c",
"title": "9bef2842301dcccff4d1a7d0681d167f387ff79c",
"url": "https://chromium.googlesource.com/chromium/src/+/9bef2842301dcccff4d1a7d0681d167f387ff79c"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b2d9d3bb528ad48adc3e5b5e8cb43f30760710f1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@b2d9d3bb528ad48adc3e5b5e8cb43f30760710f1",
"title": "b2d9d3bb528ad48adc3e5b5e8cb43f30760710f1",
"url": "https://chromium.googlesource.com/chromium/src/+/b2d9d3bb528ad48adc3e5b5e8cb43f30760710f1"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6780722ec022c40e7593c0c83edef69c9ac819dd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@6780722ec022c40e7593c0c83edef69c9ac819dd",
"title": "6780722ec022c40e7593c0c83edef69c9ac819dd",
"url": "https://chromium.googlesource.com/chromium/src/+/6780722ec022c40e7593c0c83edef69c9ac819dd"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0c7c2275aac443b514c5611a96b3fa9d1a2f8062"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@0c7c2275aac443b514c5611a96b3fa9d1a2f8062",
"title": "0c7c2275aac443b514c5611a96b3fa9d1a2f8062",
"url": "https://chromium.googlesource.com/chromium/src/+/0c7c2275aac443b514c5611a96b3fa9d1a2f8062"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ab8e7c2e338352bc74bd369fa9bfc76a8c1d1f07"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@ab8e7c2e338352bc74bd369fa9bfc76a8c1d1f07",
"title": "ab8e7c2e338352bc74bd369fa9bfc76a8c1d1f07",
"url": "https://chromium.googlesource.com/chromium/src/+/ab8e7c2e338352bc74bd369fa9bfc76a8c1d1f07"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aedbd29b587fb97773d0705ceee03adc2e79f71a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@aedbd29b587fb97773d0705ceee03adc2e79f71a",
"title": "aedbd29b587fb97773d0705ceee03adc2e79f71a",
"url": "https://chromium.googlesource.com/chromium/src/+/aedbd29b587fb97773d0705ceee03adc2e79f71a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "63d1848b455bb85ff9cc7bc674cbefd79a0fe464"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@63d1848b455bb85ff9cc7bc674cbefd79a0fe464",
"title": "63d1848b455bb85ff9cc7bc674cbefd79a0fe464",
"url": "https://chromium.googlesource.com/chromium/src/+/63d1848b455bb85ff9cc7bc674cbefd79a0fe464"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c7af53fb963b51a776724ad3ff757effc2bc89e1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@c7af53fb963b51a776724ad3ff757effc2bc89e1",
"title": "c7af53fb963b51a776724ad3ff757effc2bc89e1",
"url": "https://chromium.googlesource.com/chromium/src/+/c7af53fb963b51a776724ad3ff757effc2bc89e1"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b72b14d2b001e183a76bbef6c38277b9b74d68bc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@b72b14d2b001e183a76bbef6c38277b9b74d68bc",
"title": "b72b14d2b001e183a76bbef6c38277b9b74d68bc",
"url": "https://chromium.googlesource.com/chromium/src/+/b72b14d2b001e183a76bbef6c38277b9b74d68bc"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9bf0fbc417dd81f03541eba96823ec1c4c65d55e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@9bf0fbc417dd81f03541eba96823ec1c4c65d55e",
"title": "9bf0fbc417dd81f03541eba96823ec1c4c65d55e",
"url": "https://chromium.googlesource.com/chromium/src/+/9bf0fbc417dd81f03541eba96823ec1c4c65d55e"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "58177b34bae0600c14ddd1207153da1dce5b7f28"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@58177b34bae0600c14ddd1207153da1dce5b7f28",
"title": "58177b34bae0600c14ddd1207153da1dce5b7f28",
"url": "https://chromium.googlesource.com/chromium/src/+/58177b34bae0600c14ddd1207153da1dce5b7f28"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ddb63e80f2e97db05ab7e10e7f6f884128e1dc42"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@ddb63e80f2e97db05ab7e10e7f6f884128e1dc42",
"title": "ddb63e80f2e97db05ab7e10e7f6f884128e1dc42",
"url": "https://chromium.googlesource.com/chromium/src/+/ddb63e80f2e97db05ab7e10e7f6f884128e1dc42"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a41c1eb09f7da651a8c921ebe1ebfa9c51123ff3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@a41c1eb09f7da651a8c921ebe1ebfa9c51123ff3",
"title": "a41c1eb09f7da651a8c921ebe1ebfa9c51123ff3",
"url": "https://chromium.googlesource.com/chromium/src/+/a41c1eb09f7da651a8c921ebe1ebfa9c51123ff3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a",
"title": "0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a",
"url": "https://chromium.googlesource.com/chromium/src/+/0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a",
"ref": "refs/branch-heads/6778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893739350575239776"
},
{
"key": "scheduler_job_id",
"value": "chromium-m131/linux-cast-x64-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:50:28.606] Scheduled build:
{
"id": "8728309288419696417",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 1486,
"createdBy": "project:chromium-m131",
"createTime": "2024-12-17T10:50:28.192988995Z",
"updateTime": "2024-12-17T10:50:28.192988995Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a",
"ref": "refs/branch-heads/6778"
}
}
}
[10:50:28.606] Task URL: https://cr-buildbucket.appspot.com/build/8728309288419696417
[10:50:28.606] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:2:0) after 4m2s
[10:50:28.726] Received PubSub notification, asking Buildbucket for the build status
[10:50:28.742] Build status: SCHEDULED
[10:54:31.311] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:2:0)
[10:54:31.329] Build status: SCHEDULED
[10:54:31.329] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:4:0) after 3m49s
[10:58:20.340] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:4:0)
[10:58:20.355] Build status: SCHEDULED
[10:58:20.355] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:5:0) after 2m1s
[11:00:21.421] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:5:0)
[11:00:21.459] Build status: SCHEDULED
[11:00:21.459] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:6:0) after 3m57s
[11:00:42.735] Received PubSub notification, asking Buildbucket for the build status
[11:00:42.768] Build status: STARTED
[11:04:18.476] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:6:0)
[11:04:18.564] Build status: STARTED
[11:04:18.564] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:8:0) after 3m12s
[11:07:30.680] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:8:0)
[11:07:30.706] Build status: STARTED
[11:07:30.706] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:9:0) after 6m1s
[11:13:31.733] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:9:0)
[11:13:31.764] Build status: STARTED
[11:13:31.764] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:10:0) after 8m45s
[11:22:17.096] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:10:0)
[11:22:17.116] Build status: STARTED
[11:22:17.116] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:11:0) after 4m27s
[11:26:44.412] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:11:0)
[11:26:44.438] Build status: STARTED
[11:26:44.438] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:12:0) after 7m42s
[11:34:26.491] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:12:0)
[11:34:26.509] Build status: STARTED
[11:34:26.509] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:13:0) after 1m56s
[11:36:22.677] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:13:0)
[11:36:22.736] Build status: STARTED
[11:36:22.736] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:14:0) after 3m11s
[11:39:33.817] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:14:0)
[11:39:33.833] Build status: STARTED
[11:39:33.833] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:15:0) after 3m22s
[11:42:56.277] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:15:0)
[11:42:56.295] Build status: STARTED
[11:42:56.295] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:16:0) after 7m30s
[11:50:26.315] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:16:0)
[11:50:26.338] Build status: STARTED
[11:50:26.338] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:17:0) after 3m22s
[11:53:48.582] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:17:0)
[11:53:48.605] Build status: STARTED
[11:53:48.605] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:18:0) after 4m51s
[11:58:39.710] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:18:0)
[11:58:39.731] Build status: STARTED
[11:58:39.732] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:19:0) after 6m3s
[12:04:42.755] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:19:0)
[12:04:42.779] Build status: STARTED
[12:04:42.779] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:20:0) after 6m33s
[12:11:15.801] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:20:0)
[12:11:15.885] Build status: STARTED
[12:11:15.885] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:21:0) after 6m23s
[12:17:38.904] Handling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:21:0)
[12:17:38.922] Build status: STARTED
[12:17:38.922] Scheduling timer "check-buildbucket-build-status" (chromium-m131/linux-cast-x64-dbg:8893739350575239776:22:0) after 8m18s
[12:24:27.426] Received PubSub notification, asking Buildbucket for the build status
[12:24:27.497] Build:
{
"id": "8728309288419696417",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "linux-cast-x64-dbg"
},
"number": 1486,
"createdBy": "project:chromium-m131",
"createTime": "2024-12-17T10:50:28.192988995Z",
"startTime": "2024-12-17T11:00:42.494762857Z",
"endTime": "2024-12-17T12:24:27.020021959Z",
"updateTime": "2024-12-17T12:24:27.020021959Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0ac1fbdab6855a9cc2c869f5f5a43bae9b25812a",
"ref": "refs/branch-heads/6778"
}
}
}
[12:24:27.497] Invocation finished in 1h34m0.744300837s with status SUCCEEDED