[12:46:14.760] New invocation is queued and will start shortly
[12:46:14.760] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[12:46:16.108] Starting the invocation (attempt 1)
[12:46:16.134] Ignoring gitiles_ref tag without the buildset tag
[12:46:16.134] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:46:16.136] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:46:16.136] Buildbucket request:
{
"requestId": "8925441003306586416",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8925441003306586416",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "cd422db1937f41a9ff39fbab156ca8f245fb4b35",
"codesearch_mirror_revision_timestamp": 1704195979,
"root_solution_revision": "ed884643ae25fc3d17530a7780d8cc15e4f35a58",
"root_solution_revision_timestamp": 1704195713
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:18687",
"user_agent:recipe"
]
},
"id": "e9704837-2f74-41ba-991f-ef32c5add980",
"title": "codesearch-gen-chromium-initiator/18687"
}
]
},
"codesearch_mirror_revision": "cd422db1937f41a9ff39fbab156ca8f245fb4b35",
"codesearch_mirror_revision_timestamp": 1704195979,
"root_solution_revision": "ed884643ae25fc3d17530a7780d8cc15e4f35a58",
"root_solution_revision_timestamp": 1704195713
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8925441003306586416"
},
{
"key": "scheduler_job_id",
"value": "infra/codesearch-gen-chromium-win"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "codesearch-gen-chromium-initiator"
},
{
"key": "parent_buildnumber",
"value": "18687"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:46:16.691] Scheduled build:
{
"id": "8760010941121251841",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 12932,
"createdBy": "project:infra",
"createTime": "2024-01-02T12:46:16.222400431Z",
"updateTime": "2024-01-02T12:46:16.222400431Z",
"status": "SCHEDULED",
"input": {
}
}
[12:46:16.691] Task URL: https://cr-buildbucket.appspot.com/build/8760010941121251841
[12:46:16.691] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:2:0) after 1m4s
[12:46:17.584] Received PubSub notification, asking Buildbucket for the build status
[12:46:17.607] Build status: SCHEDULED
[12:47:20.839] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:2:0)
[12:47:20.884] Build status: SCHEDULED
[12:47:20.884] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:4:0) after 5m37s
[12:48:05.761] Received PubSub notification, asking Buildbucket for the build status
[12:48:05.793] Build status: STARTED
[12:52:57.896] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:4:0)
[12:52:57.915] Build status: STARTED
[12:52:57.915] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:6:0) after 5m10s
[12:58:07.939] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:6:0)
[12:58:07.957] Build status: STARTED
[12:58:07.957] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:7:0) after 5m20s
[13:03:28.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:7:0)
[13:03:28.059] Build status: STARTED
[13:03:28.059] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:8:0) after 4m21s
[13:07:49.076] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:8:0)
[13:07:49.150] Build status: STARTED
[13:07:49.150] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:9:0) after 2m10s
[13:09:59.236] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:9:0)
[13:09:59.270] Build status: STARTED
[13:09:59.270] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:10:0) after 4m36s
[13:14:35.352] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:10:0)
[13:14:35.389] Build status: STARTED
[13:14:35.389] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:11:0) after 5m1s
[13:19:36.640] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:11:0)
[13:19:36.667] Build status: STARTED
[13:19:36.667] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:12:0) after 4m39s
[13:24:15.818] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:12:0)
[13:24:15.864] Build status: STARTED
[13:24:15.864] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:13:0) after 3m10s
[13:27:25.896] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:13:0)
[13:27:25.937] Build status: STARTED
[13:27:25.937] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:14:0) after 8m47s
[13:36:13.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:14:0)
[13:36:13.533] Build status: STARTED
[13:36:13.533] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:15:0) after 4m59s
[13:41:12.587] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:15:0)
[13:41:12.615] Build status: STARTED
[13:41:12.615] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:16:0) after 4m4s
[13:45:17.201] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:16:0)
[13:45:17.218] Build status: STARTED
[13:45:17.218] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:17:0) after 9m55s
[13:55:12.264] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:17:0)
[13:55:12.357] Build status: STARTED
[13:55:12.357] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:18:0) after 9m17s
[14:04:29.371] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:18:0)
[14:04:29.389] Build status: STARTED
[14:04:29.389] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:19:0) after 1m16s
[14:05:45.406] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:19:0)
[14:05:45.434] Build status: STARTED
[14:05:45.434] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:20:0) after 2m25s
[14:08:10.453] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:20:0)
[14:08:10.473] Build status: STARTED
[14:08:10.473] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:21:0) after 4m4s
[14:12:14.615] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:21:0)
[14:12:14.676] Build status: STARTED
[14:12:14.676] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:22:0) after 3m9s
[14:15:23.689] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:22:0)
[14:15:23.821] Build status: STARTED
[14:15:23.821] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:23:0) after 2m13s
[14:17:36.854] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:23:0)
[14:17:36.871] Build status: STARTED
[14:17:36.871] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:24:0) after 5m2s
[14:22:38.885] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:24:0)
[14:22:38.904] Build status: STARTED
[14:22:38.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:25:0) after 4m52s
[14:27:30.924] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:25:0)
[14:27:30.985] Build status: STARTED
[14:27:30.985] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:26:0) after 1m22s
[14:28:53.006] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:26:0)
[14:28:53.033] Build status: STARTED
[14:28:53.033] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:27:0) after 4m58s
[14:33:51.047] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:27:0)
[14:33:51.087] Build status: STARTED
[14:33:51.088] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:28:0) after 1m54s
[14:35:45.105] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:28:0)
[14:35:45.145] Build status: STARTED
[14:35:45.145] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:29:0) after 6m27s
[14:42:12.169] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:29:0)
[14:42:12.222] Build status: STARTED
[14:42:12.223] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:30:0) after 7m59s
[14:50:11.305] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:30:0)
[14:50:11.330] Build status: STARTED
[14:50:11.330] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:31:0) after 6m2s
[14:56:13.360] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:31:0)
[14:56:13.387] Build status: STARTED
[14:56:13.387] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:32:0) after 3m53s
[15:00:06.597] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:32:0)
[15:00:08.083] Build status: STARTED
[15:00:08.083] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:33:0) after 2m50s
[15:02:58.333] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:33:0)
[15:02:58.543] Build status: STARTED
[15:02:58.543] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:34:0) after 9m31s
[15:12:30.080] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:34:0)
[15:12:30.202] Build status: STARTED
[15:12:30.202] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:35:0) after 3m21s
[15:15:51.235] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:35:0)
[15:15:51.287] Build status: STARTED
[15:15:51.287] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:36:0) after 8m49s
[15:24:40.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:36:0)
[15:24:40.473] Build status: STARTED
[15:24:40.473] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:37:0) after 3m1s
[15:27:41.745] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:37:0)
[15:27:41.766] Build status: STARTED
[15:27:41.766] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:38:0) after 3m20s
[15:31:01.921] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:38:0)
[15:31:02.103] Build status: STARTED
[15:31:02.103] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:39:0) after 5m2s
[15:36:04.122] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:39:0)
[15:36:04.179] Build status: STARTED
[15:36:04.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:40:0) after 8m26s
[15:44:30.451] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:40:0)
[15:44:30.487] Build status: STARTED
[15:44:30.487] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8925441003306586416:41:0) after 6m1s
[15:46:17.938] Received PubSub notification, asking Buildbucket for the build status
[15:46:18.061] Build:
{
"id": "8760010941121251841",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 12932,
"createdBy": "project:infra",
"createTime": "2024-01-02T12:46:16.222400431Z",
"startTime": "2024-01-02T12:48:05.060869Z",
"endTime": "2024-01-02T15:46:17.177605Z",
"updateTime": "2024-01-02T15:46:17.177605Z",
"status": "SUCCESS",
"input": {
}
}
[15:46:18.061] Invocation finished in 3h0m3.305707978s with status SUCCEEDED