[06:20:13.340] New invocation is queued and will start shortly
[06:20:13.340] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[06:20:14.429] Starting the invocation (attempt 1)
[06:20:14.454] Ignoring gitiles_ref tag without the buildset tag
[06:20:14.454] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:20:14.454] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:20:14.454] Buildbucket request:
{
"requestId": "8914684250823529584",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914684250823529584",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "9a8ae8134048fd5156d48cd0c81efa4fc417ba3a",
"codesearch_mirror_revision_timestamp": 1714449433,
"root_solution_revision": "b3ec844095f12516303eb2492f8875ce15a8b03e",
"root_solution_revision_timestamp": 1714448864
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:19400",
"user_agent:recipe"
]
},
"id": "631ede56-6d2a-4996-8faa-faea16bfd774",
"title": "codesearch-gen-chromium-initiator/19400"
}
]
},
"codesearch_mirror_revision": "9a8ae8134048fd5156d48cd0c81efa4fc417ba3a",
"codesearch_mirror_revision_timestamp": 1714449433,
"root_solution_revision": "b3ec844095f12516303eb2492f8875ce15a8b03e",
"root_solution_revision_timestamp": 1714448864
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914684250823529584"
},
{
"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": "19400"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:20:15.014] Scheduled build:
{
"id": "8749254188906982065",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 13644,
"createdBy": "project:infra",
"createTime": "2024-04-30T06:20:14.537231904Z",
"updateTime": "2024-04-30T06:20:14.537231904Z",
"status": "SCHEDULED",
"input": {
}
}
[06:20:15.014] Task URL: https://cr-buildbucket.appspot.com/build/8749254188906982065
[06:20:15.014] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:2:0) after 5m27s
[06:20:21.959] Received PubSub notification, asking Buildbucket for the build status
[06:20:22.032] Build status: SCHEDULED
[06:20:28.910] Received PubSub notification, asking Buildbucket for the build status
[06:20:28.931] Build status: STARTED
[06:25:42.277] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:2:0)
[06:25:42.311] Build status: STARTED
[06:25:42.311] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:5:0) after 9m3s
[06:34:45.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:5:0)
[06:34:45.526] Build status: STARTED
[06:34:45.526] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:6:0) after 1m45s
[06:36:30.521] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:6:0)
[06:36:30.545] Build status: STARTED
[06:36:30.545] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:7:0) after 2m44s
[06:39:14.561] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:7:0)
[06:39:14.586] Build status: STARTED
[06:39:14.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:8:0) after 6m16s
[06:45:30.710] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:8:0)
[06:45:30.733] Build status: STARTED
[06:45:30.733] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:9:0) after 4m34s
[06:50:04.886] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:9:0)
[06:50:05.013] Build status: STARTED
[06:50:05.013] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:10:0) after 2m40s
[06:52:45.235] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:10:0)
[06:52:45.269] Build status: STARTED
[06:52:45.269] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:11:0) after 6m54s
[06:59:39.494] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:11:0)
[06:59:39.520] Build status: STARTED
[06:59:39.520] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:12:0) after 5m33s
[07:05:12.544] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:12:0)
[07:05:12.615] Build status: STARTED
[07:05:12.615] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:13:0) after 2m28s
[07:07:40.878] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:13:0)
[07:07:40.912] Build status: STARTED
[07:07:40.912] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:14:0) after 4m47s
[07:12:27.936] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:14:0)
[07:12:28.105] Build status: STARTED
[07:12:28.105] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:15:0) after 5m17s
[07:17:45.234] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:15:0)
[07:17:45.259] Build status: STARTED
[07:17:45.259] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:16:0) after 8m43s
[07:26:28.496] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:16:0)
[07:26:28.549] Build status: STARTED
[07:26:28.549] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:17:0) after 2m37s
[07:29:05.628] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:17:0)
[07:29:05.710] Build status: STARTED
[07:29:05.710] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:18:0) after 6m29s
[07:35:34.796] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:18:0)
[07:35:34.853] Build status: STARTED
[07:35:34.853] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:19:0) after 2m26s
[07:38:00.893] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:19:0)
[07:38:00.926] Build status: STARTED
[07:38:00.926] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:20:0) after 5m51s
[07:43:51.947] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:20:0)
[07:43:52.058] Build status: STARTED
[07:43:52.058] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:21:0) after 7m9s
[07:51:01.253] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:21:0)
[07:51:01.272] Build status: STARTED
[07:51:01.272] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:22:0) after 2m10s
[07:53:11.426] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:22:0)
[07:53:11.467] Build status: STARTED
[07:53:11.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:23:0) after 9m46s
[08:02:57.754] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:23:0)
[08:02:57.857] Build status: STARTED
[08:02:57.857] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:24:0) after 3m18s
[08:06:16.462] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:24:0)
[08:06:16.550] Build status: STARTED
[08:06:16.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:25:0) after 1m22s
[08:07:38.679] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:25:0)
[08:07:38.728] Build status: STARTED
[08:07:38.728] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:26:0) after 7m57s
[08:15:35.746] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:26:0)
[08:15:35.793] Build status: STARTED
[08:15:35.793] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:27:0) after 5m50s
[08:21:26.008] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:27:0)
[08:21:26.036] Build status: STARTED
[08:21:26.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:28:0) after 1m6s
[08:22:32.113] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:28:0)
[08:22:32.131] Build status: STARTED
[08:22:32.131] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:29:0) after 6m22s
[08:28:54.214] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:29:0)
[08:28:54.315] Build status: STARTED
[08:28:54.315] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:30:0) after 5m28s
[08:34:22.491] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:30:0)
[08:34:22.528] Build status: STARTED
[08:34:22.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:31:0) after 3m9s
[08:37:31.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:31:0)
[08:37:31.753] Build status: STARTED
[08:37:31.753] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:32:0) after 8m31s
[08:46:03.553] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:32:0)
[08:46:03.592] Build status: STARTED
[08:46:03.592] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:33:0) after 3m26s
[08:49:29.702] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:33:0)
[08:49:29.734] Build status: STARTED
[08:49:29.734] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:34:0) after 4m52s
[08:54:21.770] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:34:0)
[08:54:21.808] Build status: STARTED
[08:54:21.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:35:0) after 7m55s
[09:02:16.947] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:35:0)
[09:02:16.965] Build status: STARTED
[09:02:16.965] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:36:0) after 7m56s
[09:10:13.077] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:36:0)
[09:10:13.105] Build status: STARTED
[09:10:13.105] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:37:0) after 1m20s
[09:11:33.229] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:37:0)
[09:11:33.288] Build status: STARTED
[09:11:33.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:38:0) after 4m18s
[09:15:51.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:38:0)
[09:15:51.362] Build status: STARTED
[09:15:51.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:39:0) after 2m59s
[09:18:50.472] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:39:0)
[09:18:50.526] Build status: STARTED
[09:18:50.526] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:40:0) after 9m27s
[09:28:17.596] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:40:0)
[09:28:17.639] Build status: STARTED
[09:28:17.639] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8914684250823529584:41:0) after 8m8s
[09:34:37.652] Received PubSub notification, asking Buildbucket for the build status
[09:34:37.692] Build:
{
"id": "8749254188906982065",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 13644,
"createdBy": "project:infra",
"createTime": "2024-04-30T06:20:14.537231904Z",
"startTime": "2024-04-30T06:20:22.029441999Z",
"endTime": "2024-04-30T09:34:18.674006918Z",
"updateTime": "2024-04-30T09:34:18.674006918Z",
"status": "SUCCESS",
"input": {
}
}
[09:34:37.692] Invocation finished in 3h14m24.36538698s with status SUCCEEDED