[19:23:41.717] New invocation is queued and will start shortly
[19:23:42.922] Starting the invocation (attempt 1)
[19:23:42.956] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/777ddb9a8fa05e0a515f354f96b013e40424ddea"
[19:23:42.956] Popped gitiles commit info from properties and tags
[19:23:42.956] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:23:42.956] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:23:42.956] Buildbucket request:
{
"requestId": "8893888253661751136",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "chromeos-jacuzzi-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893888253661751136",
"job": "chromium-m132/chromeos-jacuzzi-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f491e5b0ae89f8d260b6523f454f2d6c8f6ed668"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@f491e5b0ae89f8d260b6523f454f2d6c8f6ed668",
"title": "f491e5b0ae89f8d260b6523f454f2d6c8f6ed668",
"url": "https://chromium.googlesource.com/chromium/src/+/f491e5b0ae89f8d260b6523f454f2d6c8f6ed668"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2d236685803f478419a0d9e1392b90dc5a788b9f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@2d236685803f478419a0d9e1392b90dc5a788b9f",
"title": "2d236685803f478419a0d9e1392b90dc5a788b9f",
"url": "https://chromium.googlesource.com/chromium/src/+/2d236685803f478419a0d9e1392b90dc5a788b9f"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ed00382b3b20cc6105ab1bd5d381adf115554ad0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@ed00382b3b20cc6105ab1bd5d381adf115554ad0",
"title": "ed00382b3b20cc6105ab1bd5d381adf115554ad0",
"url": "https://chromium.googlesource.com/chromium/src/+/ed00382b3b20cc6105ab1bd5d381adf115554ad0"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "777ddb9a8fa05e0a515f354f96b013e40424ddea"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@777ddb9a8fa05e0a515f354f96b013e40424ddea",
"title": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"url": "https://chromium.googlesource.com/chromium/src/+/777ddb9a8fa05e0a515f354f96b013e40424ddea"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893888253661751136"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/chromeos-jacuzzi-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:23:43.772] Scheduled build:
{
"id": "8728458191634581265",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "chromeos-jacuzzi-rel"
},
"number": 432,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-15T19:23:43.020206286Z",
"updateTime": "2024-12-15T19:23:43.020206286Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"ref": "refs/branch-heads/6834"
}
}
}
[19:23:43.772] Task URL: https://cr-buildbucket.appspot.com/build/8728458191634581265
[19:23:43.772] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:2:0) after 2m29s
[19:23:44.802] Received PubSub notification, asking Buildbucket for the build status
[19:23:44.839] Build status: SCHEDULED
[19:26:12.788] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:2:0)
[19:26:12.929] Build status: SCHEDULED
[19:26:12.929] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:4:0) after 1m48s
[19:28:01.045] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:4:0)
[19:28:01.283] Build status: SCHEDULED
[19:28:01.283] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:5:0) after 7m5s
[19:35:06.300] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:5:0)
[19:35:06.338] Build status: SCHEDULED
[19:35:06.338] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:6:0) after 5m20s
[19:37:51.463] Received PubSub notification, asking Buildbucket for the build status
[19:37:51.480] Build status: STARTED
[19:40:26.377] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:6:0)
[19:40:26.460] Build status: STARTED
[19:40:26.460] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:8:0) after 2m8s
[19:42:34.520] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:8:0)
[19:42:34.534] Build status: STARTED
[19:42:34.535] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:9:0) after 3m11s
[19:45:45.650] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:9:0)
[19:45:45.675] Build status: STARTED
[19:45:45.675] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:10:0) after 8m2s
[19:53:47.690] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:10:0)
[19:53:47.711] Build status: STARTED
[19:53:47.711] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:11:0) after 7m34s
[20:01:21.941] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:11:0)
[20:01:21.971] Build status: STARTED
[20:01:21.971] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:12:0) after 7m25s
[20:08:46.984] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:12:0)
[20:08:47.074] Build status: STARTED
[20:08:47.074] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:13:0) after 3m33s
[20:12:20.369] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:13:0)
[20:12:20.388] Build status: STARTED
[20:12:20.388] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:14:0) after 5m14s
[20:17:34.837] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:14:0)
[20:17:34.855] Build status: STARTED
[20:17:34.855] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:15:0) after 8m36s
[20:26:10.871] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:15:0)
[20:26:10.893] Build status: STARTED
[20:26:10.893] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:16:0) after 9m47s
[20:35:58.165] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:16:0)
[20:35:58.189] Build status: STARTED
[20:35:58.189] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:17:0) after 3m46s
[20:39:44.208] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:17:0)
[20:39:44.232] Build status: STARTED
[20:39:44.232] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:18:0) after 2m32s
[20:42:16.524] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:18:0)
[20:42:16.544] Build status: STARTED
[20:42:16.544] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:19:0) after 1m27s
[20:43:43.660] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:19:0)
[20:43:43.675] Build status: STARTED
[20:43:43.675] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:20:0) after 3m11s
[20:46:54.734] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:20:0)
[20:46:54.752] Build status: STARTED
[20:46:54.752] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:21:0) after 2m29s
[20:49:23.852] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:21:0)
[20:49:23.922] Build status: STARTED
[20:49:23.922] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:22:0) after 4m40s
[20:54:04.304] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:22:0)
[20:54:04.324] Build status: STARTED
[20:54:04.324] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:23:0) after 3m30s
[20:57:34.485] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:23:0)
[20:57:34.602] Build status: STARTED
[20:57:34.603] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:24:0) after 1m52s
[20:59:26.621] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:24:0)
[20:59:26.700] Build status: STARTED
[20:59:26.700] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:25:0) after 2m40s
[21:02:06.817] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:25:0)
[21:02:06.836] Build status: STARTED
[21:02:06.837] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:26:0) after 3m34s
[21:05:40.958] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:26:0)
[21:05:41.061] Build status: STARTED
[21:05:41.061] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:27:0) after 8m2s
[21:13:43.277] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:27:0)
[21:13:43.299] Build status: STARTED
[21:13:43.299] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:28:0) after 6m44s
[21:20:27.452] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:28:0)
[21:20:27.472] Build status: STARTED
[21:20:27.472] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:29:0) after 1m52s
[21:22:19.562] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:29:0)
[21:22:19.600] Build status: STARTED
[21:22:19.600] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:30:0) after 4m1s
[21:26:20.804] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:30:0)
[21:26:20.835] Build status: STARTED
[21:26:20.835] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:31:0) after 7m25s
[21:33:45.851] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:31:0)
[21:33:45.891] Build status: STARTED
[21:33:45.891] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-jacuzzi-rel:8893888253661751136:32:0) after 8m52s
[21:38:29.649] Received PubSub notification, asking Buildbucket for the build status
[21:38:29.691] Build:
{
"id": "8728458191634581265",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "chromeos-jacuzzi-rel"
},
"number": 432,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-15T19:23:43.020206286Z",
"startTime": "2024-12-15T19:37:48.989818145Z",
"endTime": "2024-12-15T21:38:29.174034759Z",
"updateTime": "2024-12-15T21:38:29.174034759Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"ref": "refs/branch-heads/6834"
}
}
}
[21:38:29.691] Invocation finished in 2h14m47.987917893s with status FAILED