[16:28:53.496] New invocation is queued and will start shortly
[16:28:53.496] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[16:28:54.573] Starting the invocation (attempt 1)
[16:28:54.610] Ignoring gitiles_ref tag without the buildset tag
[16:28:54.610] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:28:54.611] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:28:54.611] Buildbucket request:
{
"requestId": "8945267731308698496",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8945267731308698496",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "58f2ba4681db80bc05f1a790bfaad82d893355fa",
"codesearch_mirror_revision_timestamp": 1685288536,
"root_solution_revision": "52070be21bff4c7b760cc2fcbd6c1b53db6f72ba",
"root_solution_revision_timestamp": 1685288379
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17374",
"user_agent:recipe"
]
},
"id": "8d89cd76-140d-48c2-b245-9a3c5fbbc37f",
"title": "codesearch-gen-chromium-initiator/17374"
}
]
},
"codesearch_mirror_revision": "58f2ba4681db80bc05f1a790bfaad82d893355fa",
"codesearch_mirror_revision_timestamp": 1685288536,
"root_solution_revision": "52070be21bff4c7b760cc2fcbd6c1b53db6f72ba",
"root_solution_revision_timestamp": 1685288379
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945267731308698496"
},
{
"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": "17374"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:28:54.968] Scheduled build:
{
"id": "8779837669417426401",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11927,
"createdBy": "project:infra",
"createTime": "2023-05-28T16:28:54.668403631Z",
"updateTime": "2023-05-28T16:28:54.668403631Z",
"status": "SCHEDULED",
"input": {
}
}
[16:28:54.968] Task URL: https://cr-buildbucket.appspot.com/build/8779837669417426401
[16:28:54.968] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:2:0) after 5m37s
[16:29:41.083] Received PubSub notification, asking Buildbucket for the build status
[16:29:41.129] Build status: STARTED
[16:34:32.056] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:2:0)
[16:34:32.086] Build status: STARTED
[16:34:32.087] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:4:0) after 7m10s
[16:41:42.106] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:4:0)
[16:41:42.141] Build status: STARTED
[16:41:42.141] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:5:0) after 8m57s
[16:50:39.158] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:5:0)
[16:50:39.205] Build status: STARTED
[16:50:39.205] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:6:0) after 1m26s
[16:52:05.226] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:6:0)
[16:52:05.258] Build status: STARTED
[16:52:05.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:7:0) after 4m15s
[16:56:20.306] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:7:0)
[16:56:20.325] Build status: STARTED
[16:56:20.325] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:8:0) after 1m2s
[16:57:22.447] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:8:0)
[16:57:22.473] Build status: STARTED
[16:57:22.473] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:9:0) after 3m55s
[17:01:17.506] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:9:0)
[17:01:17.548] Build status: STARTED
[17:01:17.548] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:10:0) after 5m29s
[17:06:46.567] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:10:0)
[17:06:46.591] Build status: STARTED
[17:06:46.591] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:11:0) after 1m44s
[17:08:30.598] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:11:0)
[17:08:30.643] Build status: STARTED
[17:08:30.643] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:12:0) after 6m36s
[17:15:06.848] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:12:0)
[17:15:06.876] Build status: STARTED
[17:15:06.876] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:13:0) after 4m56s
[17:20:03.027] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:13:0)
[17:20:03.053] Build status: STARTED
[17:20:03.053] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:14:0) after 6m21s
[17:26:24.075] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:14:0)
[17:26:24.130] Build status: STARTED
[17:26:24.131] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:15:0) after 4m15s
[17:30:39.152] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:15:0)
[17:30:39.178] Build status: STARTED
[17:30:39.178] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:16:0) after 8m42s
[17:39:21.401] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:16:0)
[17:39:21.427] Build status: STARTED
[17:39:21.427] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:17:0) after 5m53s
[17:45:14.561] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:17:0)
[17:45:14.607] Build status: STARTED
[17:45:14.607] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:18:0) after 4m50s
[17:50:04.639] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:18:0)
[17:50:04.666] Build status: STARTED
[17:50:04.666] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:19:0) after 1m53s
[17:51:57.907] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:19:0)
[17:51:57.949] Build status: STARTED
[17:51:57.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:20:0) after 1m55s
[17:53:53.023] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:20:0)
[17:53:53.063] Build status: STARTED
[17:53:53.063] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:21:0) after 3m28s
[17:57:21.095] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:21:0)
[17:57:21.132] Build status: STARTED
[17:57:21.132] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:22:0) after 6m20s
[18:03:41.211] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:22:0)
[18:03:41.235] Build status: STARTED
[18:03:41.235] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:23:0) after 1m34s
[18:05:15.388] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:23:0)
[18:05:15.409] Build status: STARTED
[18:05:15.409] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:24:0) after 1m52s
[18:07:07.614] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:24:0)
[18:07:07.633] Build status: STARTED
[18:07:07.633] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:25:0) after 9m24s
[18:16:31.690] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:25:0)
[18:16:31.718] Build status: STARTED
[18:16:31.718] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:26:0) after 2m51s
[18:19:22.733] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:26:0)
[18:19:22.749] Build status: STARTED
[18:19:22.749] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:27:0) after 5m10s
[18:24:32.765] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:27:0)
[18:24:32.798] Build status: STARTED
[18:24:32.798] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:28:0) after 7m37s
[18:32:09.815] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:28:0)
[18:32:09.846] Build status: STARTED
[18:32:09.846] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:29:0) after 2m51s
[18:35:00.906] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:29:0)
[18:35:00.928] Build status: STARTED
[18:35:00.928] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:30:0) after 7m38s
[18:42:38.941] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:30:0)
[18:42:39.047] Build status: STARTED
[18:42:39.047] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:31:0) after 2m36s
[18:45:15.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:31:0)
[18:45:15.321] Build status: STARTED
[18:45:15.321] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:32:0) after 8m21s
[18:53:36.342] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:32:0)
[18:53:36.360] Build status: STARTED
[18:53:36.360] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:33:0) after 9m16s
[19:02:52.669] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:33:0)
[19:02:52.702] Build status: STARTED
[19:02:52.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:34:0) after 8m58s
[19:11:50.720] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:34:0)
[19:11:50.762] Build status: STARTED
[19:11:50.762] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:35:0) after 5m4s
[19:16:54.776] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:35:0)
[19:16:54.815] Build status: STARTED
[19:16:54.815] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:36:0) after 9m35s
[19:26:29.948] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:36:0)
[19:26:29.984] Build status: STARTED
[19:26:29.984] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:37:0) after 5m43s
[19:32:13.047] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:37:0)
[19:32:13.086] Build status: STARTED
[19:32:13.086] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:38:0) after 1m23s
[19:33:36.119] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:38:0)
[19:33:36.149] Build status: STARTED
[19:33:36.149] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:39:0) after 3m40s
[19:37:16.287] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:39:0)
[19:37:16.342] Build status: STARTED
[19:37:16.342] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:40:0) after 3m36s
[19:40:52.359] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:40:0)
[19:40:52.380] Build status: STARTED
[19:40:52.380] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:41:0) after 6m4s
[19:46:56.406] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:41:0)
[19:46:56.436] Build status: STARTED
[19:46:56.436] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:42:0) after 1m58s
[19:48:54.522] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:42:0)
[19:48:54.544] Build status: STARTED
[19:48:54.544] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:43:0) after 1m11s
[19:50:05.552] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:43:0)
[19:50:05.621] Build status: STARTED
[19:50:05.621] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:44:0) after 4m27s
[19:54:33.326] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:44:0)
[19:54:33.376] Build status: STARTED
[19:54:33.376] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:45:0) after 1m49s
[19:56:22.623] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:45:0)
[19:56:22.654] Build status: STARTED
[19:56:22.654] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:46:0) after 7m58s
[20:04:20.699] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:46:0)
[20:04:20.734] Build status: STARTED
[20:04:20.734] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:47:0) after 3m3s
[20:07:23.988] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:47:0)
[20:07:24.035] Build status: STARTED
[20:07:24.035] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:48:0) after 1m27s
[20:08:51.383] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:48:0)
[20:08:51.407] Build status: STARTED
[20:08:51.407] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:49:0) after 8m41s
[20:17:32.598] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:49:0)
[20:17:32.645] Build status: STARTED
[20:17:32.645] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:50:0) after 1m58s
[20:19:30.663] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:50:0)
[20:19:30.682] Build status: STARTED
[20:19:30.682] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:51:0) after 5m9s
[20:24:39.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:51:0)
[20:24:39.833] Build status: STARTED
[20:24:39.833] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:52:0) after 6m50s
[20:31:30.173] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:52:0)
[20:31:30.195] Build status: STARTED
[20:31:30.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:53:0) after 8m29s
[20:39:59.235] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:53:0)
[20:39:59.266] Build status: STARTED
[20:39:59.266] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:54:0) after 2m13s
[20:42:12.435] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:54:0)
[20:42:12.590] Build status: STARTED
[20:42:12.590] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:55:0) after 9m6s
[20:51:18.608] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:55:0)
[20:51:18.651] Build status: STARTED
[20:51:18.651] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:56:0) after 7m42s
[20:59:00.849] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:56:0)
[20:59:00.874] Build status: STARTED
[20:59:00.874] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945267731308698496:57:0) after 8m52s
[20:59:55.743] Received PubSub notification, asking Buildbucket for the build status
[20:59:55.773] Build:
{
"id": "8779837669417426401",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11927,
"createdBy": "project:infra",
"createTime": "2023-05-28T16:28:54.668403631Z",
"startTime": "2023-05-28T16:29:40.526989Z",
"endTime": "2023-05-28T20:59:55.334335019Z",
"updateTime": "2023-05-28T20:59:55.334335019Z",
"status": "SUCCESS",
"input": {
}
}
[20:59:55.773] Invocation finished in 4h31m2.291696098s with status SUCCEEDED