[19:36:41.265] New invocation is queued and will start shortly
[19:36:42.446] Starting the invocation (attempt 1)
[19:36:42.470] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/790208c715c7f672befe7fd90394518fa1c1d8c9"
[19:36:42.470] Popped gitiles commit info from properties and tags
[19:36:42.470] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:36:42.473] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:36:42.473] Buildbucket request:
{
"requestId": "8898326687591142240",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android arm64 Builder (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "790208c715c7f672befe7fd90394518fa1c1d8c9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8898326687591142240"
},
{
"key": "scheduler_job_id",
"value": "chromium/Android arm64 Builder (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:36:43.059] Scheduled build:
{
"id": "8732896625607925297",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android arm64 Builder (dbg)"
},
"number": 57681,
"createdBy": "project:chromium",
"createTime": "2024-10-27T19:36:42.534510779Z",
"updateTime": "2024-10-27T19:36:42.534510779Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "790208c715c7f672befe7fd90394518fa1c1d8c9",
"ref": "refs/heads/main"
}
}
}
[19:36:43.059] Task URL: https://cr-buildbucket.appspot.com/build/8732896625607925297
[19:36:43.059] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:2:0) after 1m27s
[19:36:43.919] Received PubSub notification, asking Buildbucket for the build status
[19:36:43.966] Build status: SCHEDULED
[19:38:10.075] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:2:0)
[19:38:10.146] Build status: SCHEDULED
[19:38:10.146] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:4:0) after 4m4s
[19:42:14.160] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:4:0)
[19:42:14.183] Build status: SCHEDULED
[19:42:14.183] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:5:0) after 2m39s
[19:44:53.215] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:5:0)
[19:44:53.244] Build status: SCHEDULED
[19:44:53.244] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:6:0) after 3m50s
[19:48:43.265] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:6:0)
[19:48:43.279] Build status: SCHEDULED
[19:48:43.280] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:7:0) after 2m38s
[19:48:51.708] Received PubSub notification, asking Buildbucket for the build status
[19:48:51.723] Build status: STARTED
[19:51:21.489] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:7:0)
[19:51:21.563] Build status: STARTED
[19:51:21.564] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:9:0) after 6m13s
[19:57:34.582] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:9:0)
[19:57:34.605] Build status: STARTED
[19:57:34.605] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:10:0) after 6m59s
[20:04:33.620] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:10:0)
[20:04:33.637] Build status: STARTED
[20:04:33.637] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:11:0) after 3m36s
[20:08:09.616] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:11:0)
[20:08:09.637] Build status: STARTED
[20:08:09.637] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:12:0) after 6m21s
[20:14:30.701] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:12:0)
[20:14:30.800] Build status: STARTED
[20:14:30.800] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:13:0) after 6m17s
[20:20:47.878] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:13:0)
[20:20:47.895] Build status: STARTED
[20:20:47.895] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:14:0) after 4m11s
[20:24:58.915] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:14:0)
[20:24:58.941] Build status: STARTED
[20:24:58.941] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:15:0) after 8m26s
[20:33:24.973] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:15:0)
[20:33:24.995] Build status: STARTED
[20:33:24.995] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:16:0) after 2m9s
[20:35:34.011] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:16:0)
[20:35:34.032] Build status: STARTED
[20:35:34.032] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:17:0) after 1m8s
[20:36:42.114] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:17:0)
[20:36:42.140] Build status: STARTED
[20:36:42.140] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:18:0) after 8m23s
[20:45:05.119] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:18:0)
[20:45:05.138] Build status: STARTED
[20:45:05.138] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:19:0) after 2m27s
[20:47:32.221] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:19:0)
[20:47:32.240] Build status: STARTED
[20:47:32.240] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:20:0) after 3m55s
[20:51:27.324] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:20:0)
[20:51:27.344] Build status: STARTED
[20:51:27.344] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:21:0) after 2m30s
[20:53:57.514] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:21:0)
[20:53:57.532] Build status: STARTED
[20:53:57.532] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:22:0) after 1m4s
[20:55:01.548] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:22:0)
[20:55:01.564] Build status: STARTED
[20:55:01.564] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:23:0) after 5m37s
[21:00:38.598] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:23:0)
[21:00:38.622] Build status: STARTED
[21:00:38.622] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:24:0) after 7m4s
[21:07:42.636] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:24:0)
[21:07:42.651] Build status: STARTED
[21:07:42.651] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:25:0) after 8m43s
[21:16:25.659] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:25:0)
[21:16:25.672] Build status: STARTED
[21:16:25.672] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:26:0) after 7m53s
[21:24:18.729] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:26:0)
[21:24:18.744] Build status: STARTED
[21:24:18.744] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:27:0) after 2m16s
[21:26:34.828] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:27:0)
[21:26:34.850] Build status: STARTED
[21:26:34.850] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:28:0) after 8m56s
[21:35:30.875] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:28:0)
[21:35:30.891] Build status: STARTED
[21:35:30.891] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:29:0) after 3m27s
[21:38:57.979] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:29:0)
[21:38:57.998] Build status: STARTED
[21:38:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:30:0) after 1m39s
[21:40:37.141] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:30:0)
[21:40:37.249] Build status: STARTED
[21:40:37.249] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:31:0) after 1m48s
[21:42:25.438] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:31:0)
[21:42:25.453] Build status: STARTED
[21:42:25.453] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:32:0) after 3m26s
[21:45:51.479] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:32:0)
[21:45:51.497] Build status: STARTED
[21:45:51.497] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:33:0) after 6m25s
[21:52:16.536] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:33:0)
[21:52:16.555] Build status: STARTED
[21:52:16.555] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:34:0) after 1m37s
[21:53:53.571] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:34:0)
[21:53:53.588] Build status: STARTED
[21:53:53.588] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:35:0) after 6m13s
[22:00:06.611] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:35:0)
[22:00:06.631] Build status: STARTED
[22:00:06.631] Scheduling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:36:0) after 7m58s
[22:08:04.650] Handling timer "check-buildbucket-build-status" (chromium/Android arm64 Builder (dbg):8898326687591142240:36:0)
[22:08:04.699] Build:
{
"id": "8732896625607925297",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android arm64 Builder (dbg)"
},
"number": 57681,
"createdBy": "project:chromium",
"createTime": "2024-10-27T19:36:42.534510779Z",
"startTime": "2024-10-27T19:48:51.523761799Z",
"endTime": "2024-10-27T22:07:26.914994252Z",
"updateTime": "2024-10-27T22:07:26.914994252Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "790208c715c7f672befe7fd90394518fa1c1d8c9",
"ref": "refs/heads/main"
}
}
}
[22:08:04.699] Invocation finished in 2h31m23.439055203s with status SUCCEEDED