[19:11:00.953] New invocation is queued and will start shortly
[19:11:02.075] Starting the invocation (attempt 1)
[19:11:02.103] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5e8d7aff47d3ef6d87caeb87da97b36da566c77b"
[19:11:02.103] Popped gitiles commit info from properties and tags
[19:11:02.103] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:11:02.103] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:11:02.103] Buildbucket request:
{
"requestId": "8901499196559273472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e8d7aff47d3ef6d87caeb87da97b36da566c77b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901499196559273472"
},
{
"key": "scheduler_job_id",
"value": "chromium/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:11:02.646] Scheduled build:
{
"id": "8736069134627753441",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 5690,
"createdBy": "project:chromium",
"createTime": "2024-09-22T19:11:02.164884547Z",
"updateTime": "2024-09-22T19:11:02.164884547Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e8d7aff47d3ef6d87caeb87da97b36da566c77b",
"ref": "refs/heads/main"
}
}
}
[19:11:02.647] Task URL: https://cr-buildbucket.appspot.com/build/8736069134627753441
[19:11:02.647] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:2:0) after 9m4s
[19:11:03.649] Received PubSub notification, asking Buildbucket for the build status
[19:11:03.680] Build status: SCHEDULED
[19:20:06.749] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:2:0)
[19:20:06.776] Build status: SCHEDULED
[19:20:06.776] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:4:0) after 9m0s
[19:29:06.793] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:4:0)
[19:29:06.813] Build status: SCHEDULED
[19:29:06.813] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:5:0) after 4m55s
[19:34:01.822] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:5:0)
[19:34:01.839] Build status: SCHEDULED
[19:34:01.840] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:6:0) after 4m31s
[19:38:32.859] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:6:0)
[19:38:32.883] Build status: SCHEDULED
[19:38:32.883] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:7:0) after 4m45s
[19:43:18.045] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:7:0)
[19:43:18.065] Build status: SCHEDULED
[19:43:18.066] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:8:0) after 5m36s
[19:48:54.183] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:8:0)
[19:48:54.198] Build status: SCHEDULED
[19:48:54.198] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:9:0) after 9m43s
[19:58:37.218] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:9:0)
[19:58:37.367] Build status: SCHEDULED
[19:58:37.367] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:10:0) after 8m25s
[20:07:02.450] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:10:0)
[20:07:02.465] Build status: SCHEDULED
[20:07:02.465] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:11:0) after 3m20s
[20:10:22.576] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:11:0)
[20:10:22.595] Build status: SCHEDULED
[20:10:22.595] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:12:0) after 6m19s
[20:16:41.613] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:12:0)
[20:16:41.632] Build status: SCHEDULED
[20:16:41.632] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:13:0) after 6m51s
[20:23:32.664] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:13:0)
[20:23:32.682] Build status: SCHEDULED
[20:23:32.682] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:14:0) after 7m58s
[20:27:11.851] Received PubSub notification, asking Buildbucket for the build status
[20:27:11.870] Build status: STARTED
[20:31:30.698] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:14:0)
[20:31:30.748] Build status: STARTED
[20:31:30.748] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:16:0) after 9m20s
[20:40:50.762] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:16:0)
[20:40:50.783] Build status: STARTED
[20:40:50.783] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:17:0) after 6m10s
[20:47:00.813] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:17:0)
[20:47:00.829] Build status: STARTED
[20:47:00.829] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:18:0) after 4m15s
[20:51:15.935] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:18:0)
[20:51:15.985] Build status: STARTED
[20:51:15.985] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:19:0) after 4m12s
[20:55:28.031] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:19:0)
[20:55:28.167] Build status: STARTED
[20:55:28.167] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:20:0) after 9m18s
[21:04:46.224] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:20:0)
[21:04:46.242] Build status: STARTED
[21:04:46.242] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:21:0) after 1m26s
[21:06:12.268] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:21:0)
[21:06:12.286] Build status: STARTED
[21:06:12.286] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:22:0) after 4m24s
[21:10:36.500] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:22:0)
[21:10:36.521] Build status: STARTED
[21:10:36.521] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:23:0) after 2m5s
[21:12:41.541] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:23:0)
[21:12:41.557] Build status: STARTED
[21:12:41.557] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:24:0) after 8m18s
[21:20:59.727] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:24:0)
[21:20:59.873] Build status: STARTED
[21:20:59.873] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:25:0) after 4m18s
[21:25:18.065] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:25:0)
[21:25:18.081] Build status: STARTED
[21:25:18.081] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:26:0) after 8m44s
[21:34:02.178] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:26:0)
[21:34:02.219] Build status: STARTED
[21:34:02.219] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:27:0) after 5m42s
[21:39:44.243] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:27:0)
[21:39:44.281] Build status: STARTED
[21:39:44.281] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:28:0) after 7m22s
[21:47:06.503] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:28:0)
[21:47:06.521] Build status: STARTED
[21:47:06.521] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:29:0) after 4m55s
[21:52:01.542] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:29:0)
[21:52:01.560] Build status: STARTED
[21:52:01.560] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:30:0) after 5m47s
[21:57:48.810] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:30:0)
[21:57:48.827] Build status: STARTED
[21:57:48.827] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:31:0) after 7m38s
[22:05:26.983] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:31:0)
[22:05:27.004] Build status: STARTED
[22:05:27.004] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:32:0) after 7m55s
[22:13:22.022] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:32:0)
[22:13:22.044] Build status: STARTED
[22:13:22.044] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:33:0) after 8m0s
[22:21:22.062] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:33:0)
[22:21:22.142] Build status: STARTED
[22:21:22.143] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:34:0) after 9m23s
[22:30:45.235] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:34:0)
[22:30:45.256] Build status: STARTED
[22:30:45.256] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:35:0) after 2m16s
[22:33:01.295] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:35:0)
[22:33:01.310] Build status: STARTED
[22:33:01.310] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:36:0) after 4m31s
[22:37:32.397] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:36:0)
[22:37:32.413] Build status: STARTED
[22:37:32.413] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:37:0) after 7m30s
[22:45:02.435] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:37:0)
[22:45:02.458] Build status: STARTED
[22:45:02.458] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:38:0) after 6m14s
[22:51:16.477] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:38:0)
[22:51:16.504] Build status: STARTED
[22:51:16.504] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:39:0) after 9m50s
[23:01:06.483] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:39:0)
[23:01:06.503] Build status: STARTED
[23:01:06.503] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:40:0) after 4m47s
[23:05:53.937] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:40:0)
[23:05:54.091] Build status: STARTED
[23:05:54.091] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:41:0) after 7m1s
[23:12:55.120] Handling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:41:0)
[23:12:55.144] Build status: STARTED
[23:12:55.144] Scheduling timer "check-buildbucket-build-status" (chromium/Android x64 Builder All Targets (dbg):8901499196559273472:42:0) after 3m57s
[23:14:25.368] Received PubSub notification, asking Buildbucket for the build status
[23:14:25.388] Build:
{
"id": "8736069134627753441",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 5690,
"createdBy": "project:chromium",
"createTime": "2024-09-22T19:11:02.164884547Z",
"startTime": "2024-09-22T20:27:11.695347757Z",
"endTime": "2024-09-22T23:14:24.812330085Z",
"updateTime": "2024-09-22T23:14:24.812330085Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5e8d7aff47d3ef6d87caeb87da97b36da566c77b",
"ref": "refs/heads/main"
}
}
}
[23:14:25.388] Invocation finished in 4h3m24.450189022s with status SUCCEEDED