[11:20:36.989] New invocation is queued and will start shortly
[11:20:38.172] Starting the invocation (attempt 1)
[11:20:38.200] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05cd827c189bbad1942d28bae7f1b037a5b4f0fe"
[11:20:38.200] Popped gitiles commit info from properties and tags
[11:20:38.200] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:20:38.200] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:20:38.200] Buildbucket request:
{
"requestId": "8889569991961787104",
"builder": {
"project": "chromium-m133",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889569991961787104",
"job": "chromium-m133/linux-chromeos-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "903dc3493f2192af38089cdc90f5f22f07210700"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@903dc3493f2192af38089cdc90f5f22f07210700",
"title": "903dc3493f2192af38089cdc90f5f22f07210700",
"url": "https://chromium.googlesource.com/chromium/src/+/903dc3493f2192af38089cdc90f5f22f07210700"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a0694c9cb563719521cad0adbf82ac6ee93c3e88"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@a0694c9cb563719521cad0adbf82ac6ee93c3e88",
"title": "a0694c9cb563719521cad0adbf82ac6ee93c3e88",
"url": "https://chromium.googlesource.com/chromium/src/+/a0694c9cb563719521cad0adbf82ac6ee93c3e88"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "49c904b668e5f9f2d70a1f06ff153a18f3f22567"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@49c904b668e5f9f2d70a1f06ff153a18f3f22567",
"title": "49c904b668e5f9f2d70a1f06ff153a18f3f22567",
"url": "https://chromium.googlesource.com/chromium/src/+/49c904b668e5f9f2d70a1f06ff153a18f3f22567"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "514f5436e32a99da8f9b55c558b1fd7cbc26f263"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@514f5436e32a99da8f9b55c558b1fd7cbc26f263",
"title": "514f5436e32a99da8f9b55c558b1fd7cbc26f263",
"url": "https://chromium.googlesource.com/chromium/src/+/514f5436e32a99da8f9b55c558b1fd7cbc26f263"
},
{
"gitiles": {
"ref": "refs/branch-heads/6943",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "05cd827c189bbad1942d28bae7f1b037a5b4f0fe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6943@05cd827c189bbad1942d28bae7f1b037a5b4f0fe",
"title": "05cd827c189bbad1942d28bae7f1b037a5b4f0fe",
"url": "https://chromium.googlesource.com/chromium/src/+/05cd827c189bbad1942d28bae7f1b037a5b4f0fe"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "05cd827c189bbad1942d28bae7f1b037a5b4f0fe",
"ref": "refs/branch-heads/6943"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889569991961787104"
},
{
"key": "scheduler_job_id",
"value": "chromium-m133/linux-chromeos-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:20:38.793] Scheduled build:
{
"id": "8724139929972296097",
"builder": {
"project": "chromium-m133",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 396,
"createdBy": "project:chromium-m133",
"createTime": "2025-02-01T11:20:38.259658687Z",
"updateTime": "2025-02-01T11:20:38.259658687Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "05cd827c189bbad1942d28bae7f1b037a5b4f0fe",
"ref": "refs/branch-heads/6943"
}
}
}
[11:20:38.793] Task URL: https://cr-buildbucket.appspot.com/build/8724139929972296097
[11:20:38.793] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:2:0) after 3m42s
[11:20:39.711] Received PubSub notification, asking Buildbucket for the build status
[11:20:39.738] Build status: SCHEDULED
[11:24:21.019] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:2:0)
[11:24:21.035] Build status: SCHEDULED
[11:24:21.035] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:4:0) after 8m28s
[11:32:44.438] Received PubSub notification, asking Buildbucket for the build status
[11:32:44.469] Build status: STARTED
[11:32:49.061] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:4:0)
[11:32:49.155] Build status: STARTED
[11:32:49.155] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:6:0) after 2m40s
[11:35:29.252] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:6:0)
[11:35:29.277] Build status: STARTED
[11:35:29.277] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:7:0) after 9m55s
[11:45:24.511] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:7:0)
[11:45:24.553] Build status: STARTED
[11:45:24.553] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:8:0) after 2m38s
[11:48:02.538] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:8:0)
[11:48:02.563] Build status: STARTED
[11:48:02.564] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:9:0) after 1m19s
[11:49:21.584] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:9:0)
[11:49:21.605] Build status: STARTED
[11:49:21.605] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:10:0) after 2m26s
[11:51:47.730] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:10:0)
[11:51:47.761] Build status: STARTED
[11:51:47.761] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:11:0) after 7m38s
[11:59:25.878] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:11:0)
[11:59:25.898] Build status: STARTED
[11:59:25.898] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:12:0) after 8m12s
[12:07:37.938] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:12:0)
[12:07:37.959] Build status: STARTED
[12:07:37.959] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:13:0) after 1m22s
[12:08:59.978] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:13:0)
[12:09:00.001] Build status: STARTED
[12:09:00.001] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:14:0) after 6m58s
[12:15:58.066] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:14:0)
[12:15:58.081] Build status: STARTED
[12:15:58.082] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:15:0) after 5m25s
[12:21:23.316] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:15:0)
[12:21:23.347] Build status: STARTED
[12:21:23.347] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:16:0) after 1m59s
[12:23:22.380] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:16:0)
[12:23:22.411] Build status: STARTED
[12:23:22.411] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:17:0) after 4m36s
[12:27:58.679] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:17:0)
[12:27:58.702] Build status: STARTED
[12:27:58.702] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:18:0) after 9m5s
[12:37:03.838] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:18:0)
[12:37:03.877] Build status: STARTED
[12:37:03.877] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:19:0) after 3m57s
[12:41:01.055] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:19:0)
[12:41:01.165] Build status: STARTED
[12:41:01.165] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:20:0) after 1m51s
[12:42:52.292] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:20:0)
[12:42:52.314] Build status: STARTED
[12:42:52.314] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:21:0) after 4m19s
[12:47:11.349] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:21:0)
[12:47:11.372] Build status: STARTED
[12:47:11.372] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:22:0) after 7m57s
[12:55:08.400] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:22:0)
[12:55:08.449] Build status: STARTED
[12:55:08.449] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:23:0) after 3m0s
[12:58:08.580] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:23:0)
[12:58:08.598] Build status: STARTED
[12:58:08.598] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:24:0) after 3m27s
[13:01:35.622] Handling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:24:0)
[13:01:35.639] Build status: STARTED
[13:01:35.639] Scheduling timer "check-buildbucket-build-status" (chromium-m133/linux-chromeos-dbg:8889569991961787104:25:0) after 7m13s
[13:08:07.682] Received PubSub notification, asking Buildbucket for the build status
[13:08:07.704] Build:
{
"id": "8724139929972296097",
"builder": {
"project": "chromium-m133",
"bucket": "ci",
"builder": "linux-chromeos-dbg"
},
"number": 396,
"createdBy": "project:chromium-m133",
"createTime": "2025-02-01T11:20:38.259658687Z",
"startTime": "2025-02-01T11:31:36.744414868Z",
"endTime": "2025-02-01T13:08:07.231214235Z",
"updateTime": "2025-02-01T13:08:07.231214235Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "05cd827c189bbad1942d28bae7f1b037a5b4f0fe",
"ref": "refs/branch-heads/6943"
}
}
}
[13:08:07.704] Invocation finished in 1h47m30.725576626s with status SUCCEEDED