[20:50:06.412] New invocation is queued and will start shortly
[20:50:07.562] Starting the invocation (attempt 1)
[20:50:07.586] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e39893b19ed5db64bc7cf6f0f697e738347242ef"
[20:50:07.587] Popped gitiles commit info from properties and tags
[20:50:07.587] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:50:07.587] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:50:07.587] Buildbucket request:
{
"requestId": "8897687889747362160",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "android-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8897687889747362160",
"job": "chromium-m131/android-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "49e47364c4154b14580392fb083c61b9aa6e78d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@49e47364c4154b14580392fb083c61b9aa6e78d3",
"title": "49e47364c4154b14580392fb083c61b9aa6e78d3",
"url": "https://chromium.googlesource.com/chromium/src/+/49e47364c4154b14580392fb083c61b9aa6e78d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f0fe92ea352dca7b1611a737bca99ca022131ce"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@4f0fe92ea352dca7b1611a737bca99ca022131ce",
"title": "4f0fe92ea352dca7b1611a737bca99ca022131ce",
"url": "https://chromium.googlesource.com/chromium/src/+/4f0fe92ea352dca7b1611a737bca99ca022131ce"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7cb47b1dda77dd2740ce9edc37ef21655d1ad644"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@7cb47b1dda77dd2740ce9edc37ef21655d1ad644",
"title": "7cb47b1dda77dd2740ce9edc37ef21655d1ad644",
"url": "https://chromium.googlesource.com/chromium/src/+/7cb47b1dda77dd2740ce9edc37ef21655d1ad644"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f8074ebb33907c8ac63b00b373613fb03e64acab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@f8074ebb33907c8ac63b00b373613fb03e64acab",
"title": "f8074ebb33907c8ac63b00b373613fb03e64acab",
"url": "https://chromium.googlesource.com/chromium/src/+/f8074ebb33907c8ac63b00b373613fb03e64acab"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2391b194bb795d318fe48c60b524dd741de27e79"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@2391b194bb795d318fe48c60b524dd741de27e79",
"title": "2391b194bb795d318fe48c60b524dd741de27e79",
"url": "https://chromium.googlesource.com/chromium/src/+/2391b194bb795d318fe48c60b524dd741de27e79"
},
{
"gitiles": {
"ref": "refs/branch-heads/6778",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e39893b19ed5db64bc7cf6f0f697e738347242ef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6778@e39893b19ed5db64bc7cf6f0f697e738347242ef",
"title": "e39893b19ed5db64bc7cf6f0f697e738347242ef",
"url": "https://chromium.googlesource.com/chromium/src/+/e39893b19ed5db64bc7cf6f0f697e738347242ef"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e39893b19ed5db64bc7cf6f0f697e738347242ef",
"ref": "refs/branch-heads/6778"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8897687889747362160"
},
{
"key": "scheduler_job_id",
"value": "chromium-m131/android-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:50:08.090] Scheduled build:
{
"id": "8732257827743158273",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "android-official"
},
"number": 259,
"createdBy": "project:chromium-m131",
"createTime": "2024-11-03T20:50:07.651791282Z",
"updateTime": "2024-11-03T20:50:07.651791282Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e39893b19ed5db64bc7cf6f0f697e738347242ef",
"ref": "refs/branch-heads/6778"
}
}
}
[20:50:08.090] Task URL: https://cr-buildbucket.appspot.com/build/8732257827743158273
[20:50:08.090] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:2:0) after 1m47s
[20:50:09.055] Received PubSub notification, asking Buildbucket for the build status
[20:50:09.080] Build status: SCHEDULED
[20:50:13.781] Received PubSub notification, asking Buildbucket for the build status
[20:50:13.798] Build status: STARTED
[20:51:55.179] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:2:0)
[20:51:55.234] Build status: STARTED
[20:51:55.234] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:5:0) after 4m47s
[20:56:42.248] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:5:0)
[20:56:42.263] Build status: STARTED
[20:56:42.263] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:6:0) after 8m37s
[21:05:19.280] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:6:0)
[21:05:19.303] Build status: STARTED
[21:05:19.304] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:7:0) after 9m14s
[21:14:33.301] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:7:0)
[21:14:33.344] Build status: STARTED
[21:14:33.344] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:8:0) after 2m36s
[21:17:09.369] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:8:0)
[21:17:09.391] Build status: STARTED
[21:17:09.391] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:9:0) after 4m25s
[21:21:34.409] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:9:0)
[21:21:34.426] Build status: STARTED
[21:21:34.426] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:10:0) after 6m1s
[21:27:35.552] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:10:0)
[21:27:35.571] Build status: STARTED
[21:27:35.571] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:11:0) after 9m0s
[21:36:35.662] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:11:0)
[21:36:35.748] Build status: STARTED
[21:36:35.748] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:12:0) after 6m51s
[21:43:27.026] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:12:0)
[21:43:27.044] Build status: STARTED
[21:43:27.044] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:13:0) after 8m17s
[21:51:44.043] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:13:0)
[21:51:44.067] Build status: STARTED
[21:51:44.067] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:14:0) after 4m4s
[21:55:48.069] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:14:0)
[21:55:48.088] Build status: STARTED
[21:55:48.088] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:15:0) after 1m51s
[21:57:39.190] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:15:0)
[21:57:39.209] Build status: STARTED
[21:57:39.209] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:16:0) after 6m2s
[22:03:41.310] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:16:0)
[22:03:41.333] Build status: STARTED
[22:03:41.333] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:17:0) after 5m28s
[22:09:09.361] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:17:0)
[22:09:09.380] Build status: STARTED
[22:09:09.380] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:18:0) after 9m50s
[22:18:59.442] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:18:0)
[22:18:59.505] Build status: STARTED
[22:18:59.505] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:19:0) after 8m31s
[22:27:30.530] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:19:0)
[22:27:30.547] Build status: STARTED
[22:27:30.547] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:20:0) after 8m22s
[22:35:52.606] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:20:0)
[22:35:52.710] Build status: STARTED
[22:35:52.710] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:21:0) after 4m42s
[22:40:34.814] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:21:0)
[22:40:35.025] Build status: STARTED
[22:40:35.025] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:22:0) after 4m57s
[22:45:32.140] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:22:0)
[22:45:32.160] Build status: STARTED
[22:45:32.160] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:23:0) after 6m6s
[22:51:38.294] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:23:0)
[22:51:38.336] Build status: STARTED
[22:51:38.336] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:24:0) after 8m1s
[22:59:39.352] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:24:0)
[22:59:39.369] Build status: STARTED
[22:59:39.369] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:25:0) after 1m32s
[23:01:11.388] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:25:0)
[23:01:11.422] Build status: STARTED
[23:01:11.422] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:26:0) after 8m52s
[23:10:03.606] Handling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:26:0)
[23:10:03.665] Build status: STARTED
[23:10:03.665] Scheduling timer "check-buildbucket-build-status" (chromium-m131/android-official:8897687889747362160:27:0) after 7m59s
[23:11:24.204] Received PubSub notification, asking Buildbucket for the build status
[23:11:24.272] Build:
{
"id": "8732257827743158273",
"builder": {
"project": "chromium-m131",
"bucket": "ci",
"builder": "android-official"
},
"number": 259,
"createdBy": "project:chromium-m131",
"createTime": "2024-11-03T20:50:07.651791282Z",
"startTime": "2024-11-03T20:50:13.337964113Z",
"endTime": "2024-11-03T23:11:23.765149906Z",
"updateTime": "2024-11-03T23:11:23.765149906Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e39893b19ed5db64bc7cf6f0f697e738347242ef",
"ref": "refs/branch-heads/6778"
}
}
}
[23:11:24.272] Invocation finished in 2h21m17.915155721s with status SUCCEEDED