[07:31:07.119] New invocation is queued and will start shortly
[07:31:07.119] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[07:31:08.242] Starting the invocation (attempt 1)
[07:31:08.271] Ignoring gitiles_ref tag without the buildset tag
[07:31:08.271] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:31:08.272] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:31:08.273] Buildbucket request:
{
"requestId": "8948744249770496928",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948744249770496928",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "6d93637b02788d221b0104d4db4ad30ad5efe379",
"codesearch_mirror_revision_timestamp": 1681963381,
"root_solution_revision": "dd81a15b6a5307e1904fbb042e7b378e13fba2c9",
"root_solution_revision_timestamp": 1681962870
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17143",
"user_agent:recipe"
]
},
"id": "b6cf6a4a-9b71-47ac-bd63-672ebf37da9d",
"title": "codesearch-gen-chromium-initiator/17143"
}
]
},
"codesearch_mirror_revision": "6d93637b02788d221b0104d4db4ad30ad5efe379",
"codesearch_mirror_revision_timestamp": 1681963381,
"root_solution_revision": "dd81a15b6a5307e1904fbb042e7b378e13fba2c9",
"root_solution_revision_timestamp": 1681962870
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948744249770496928"
},
{
"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": "17143"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:31:08.801] Scheduled build:
{
"id": "8783314187802417297",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11736,
"createdBy": "project:infra",
"createTime": "2023-04-20T07:31:08.374578236Z",
"updateTime": "2023-04-20T07:31:08.374578236Z",
"status": "SCHEDULED",
"input": {
}
}
[07:31:08.801] Task URL: https://cr-buildbucket.appspot.com/build/8783314187802417297
[07:31:08.801] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:2:0) after 3m14s
[07:31:45.686] Received PubSub notification, asking Buildbucket for the build status
[07:31:45.710] Build status: STARTED
[07:34:22.863] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:2:0)
[07:34:22.881] Build status: STARTED
[07:34:22.881] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:4:0) after 1m53s
[07:36:15.929] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:4:0)
[07:36:16.080] Build status: STARTED
[07:36:16.080] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:5:0) after 6m30s
[07:42:46.099] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:5:0)
[07:42:46.121] Build status: STARTED
[07:42:46.121] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:6:0) after 6m17s
[07:49:03.378] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:6:0)
[07:49:03.533] Build status: STARTED
[07:49:03.533] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:7:0) after 6m34s
[07:55:37.805] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:7:0)
[07:55:37.860] Build status: STARTED
[07:55:37.860] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:8:0) after 3m17s
[07:58:54.929] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:8:0)
[07:58:54.962] Build status: STARTED
[07:58:54.962] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:9:0) after 9m5s
[08:08:00.362] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:9:0)
[08:08:00.392] Build status: STARTED
[08:08:00.392] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:10:0) after 4m14s
[08:12:14.388] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:10:0)
[08:12:14.422] Build status: STARTED
[08:12:14.422] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:11:0) after 4m13s
[08:16:27.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:11:0)
[08:16:27.476] Build status: STARTED
[08:16:27.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:12:0) after 9m51s
[08:26:18.505] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:12:0)
[08:26:18.528] Build status: STARTED
[08:26:18.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:13:0) after 1m11s
[08:27:29.719] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:13:0)
[08:27:29.742] Build status: STARTED
[08:27:29.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:14:0) after 6m42s
[08:34:11.819] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:14:0)
[08:34:11.844] Build status: STARTED
[08:34:11.844] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:15:0) after 8m2s
[08:42:14.806] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:15:0)
[08:42:14.831] Build status: STARTED
[08:42:14.831] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:16:0) after 5m30s
[08:47:44.848] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:16:0)
[08:47:44.873] Build status: STARTED
[08:47:44.873] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:17:0) after 4m9s
[08:51:53.899] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:17:0)
[08:51:53.972] Build status: STARTED
[08:51:53.972] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:18:0) after 7m23s
[08:59:17.095] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:18:0)
[08:59:17.123] Build status: STARTED
[08:59:17.123] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:19:0) after 5m50s
[09:05:07.154] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:19:0)
[09:05:07.242] Build status: STARTED
[09:05:07.242] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:20:0) after 6m25s
[09:11:32.320] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:20:0)
[09:11:32.347] Build status: STARTED
[09:11:32.348] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:21:0) after 7m21s
[09:18:53.467] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:21:0)
[09:18:53.498] Build status: STARTED
[09:18:53.498] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:22:0) after 6m28s
[09:25:21.709] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:22:0)
[09:25:21.775] Build status: STARTED
[09:25:21.775] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:23:0) after 7m37s
[09:32:58.923] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:23:0)
[09:32:58.948] Build status: STARTED
[09:32:58.948] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:24:0) after 3m25s
[09:36:23.972] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:24:0)
[09:36:23.998] Build status: STARTED
[09:36:23.998] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:25:0) after 7m26s
[09:43:50.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:25:0)
[09:43:50.037] Build status: STARTED
[09:43:50.037] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:26:0) after 2m31s
[09:46:21.409] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:26:0)
[09:46:21.436] Build status: STARTED
[09:46:21.436] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:27:0) after 2m2s
[09:48:23.791] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:27:0)
[09:48:23.813] Build status: STARTED
[09:48:23.813] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:28:0) after 8m19s
[09:56:42.908] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:28:0)
[09:56:42.939] Build status: STARTED
[09:56:42.939] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:29:0) after 1m23s
[09:58:06.126] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:29:0)
[09:58:06.189] Build status: STARTED
[09:58:06.189] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:30:0) after 1m52s
[09:59:58.205] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:30:0)
[09:59:58.227] Build status: STARTED
[09:59:58.227] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:31:0) after 4m14s
[10:04:12.265] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:31:0)
[10:04:12.296] Build status: STARTED
[10:04:12.296] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:32:0) after 8m49s
[10:13:01.332] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:32:0)
[10:13:01.363] Build status: STARTED
[10:13:01.363] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:33:0) after 3m9s
[10:16:10.478] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:33:0)
[10:16:10.503] Build status: STARTED
[10:16:10.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:34:0) after 6m59s
[10:23:09.527] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:34:0)
[10:23:09.555] Build status: STARTED
[10:23:09.555] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:35:0) after 5m37s
[10:28:46.612] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:35:0)
[10:28:46.652] Build status: STARTED
[10:28:46.652] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:36:0) after 4m31s
[10:33:17.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:36:0)
[10:33:17.819] Build status: STARTED
[10:33:17.819] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:37:0) after 7m44s
[10:41:01.809] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:37:0)
[10:41:01.830] Build status: STARTED
[10:41:01.830] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:38:0) after 5m50s
[10:46:51.926] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:38:0)
[10:46:51.946] Build status: STARTED
[10:46:51.946] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:39:0) after 8m1s
[10:54:53.409] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:39:0)
[10:54:53.453] Build status: STARTED
[10:54:53.453] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:40:0) after 1m23s
[10:56:16.556] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:40:0)
[10:56:16.597] Build status: STARTED
[10:56:16.597] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:41:0) after 9m6s
[11:05:23.227] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:41:0)
[11:05:23.247] Build status: STARTED
[11:05:23.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:42:0) after 2m34s
[11:07:57.266] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:42:0)
[11:07:57.319] Build status: STARTED
[11:07:57.319] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:43:0) after 5m18s
[11:13:15.356] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:43:0)
[11:13:15.378] Build status: STARTED
[11:13:15.378] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:44:0) after 4m4s
[11:17:19.399] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:44:0)
[11:17:19.432] Build status: STARTED
[11:17:19.432] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:45:0) after 2m14s
[11:19:33.459] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:45:0)
[11:19:33.493] Build status: STARTED
[11:19:33.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:46:0) after 8m53s
[11:28:26.515] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:46:0)
[11:28:26.536] Build status: STARTED
[11:28:26.537] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:47:0) after 2m30s
[11:30:56.629] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:47:0)
[11:30:56.678] Build status: STARTED
[11:30:56.678] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:48:0) after 2m49s
[11:33:45.819] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:48:0)
[11:33:45.859] Build status: STARTED
[11:33:45.859] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:49:0) after 1m53s
[11:35:39.071] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:49:0)
[11:35:39.134] Build status: STARTED
[11:35:39.134] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:50:0) after 6m56s
[11:42:35.207] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:50:0)
[11:42:35.240] Build status: STARTED
[11:42:35.240] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:51:0) after 1m12s
[11:43:47.275] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:51:0)
[11:43:47.437] Build status: STARTED
[11:43:47.437] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:52:0) after 1m39s
[11:45:26.463] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:52:0)
[11:45:26.494] Build status: STARTED
[11:45:26.494] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:53:0) after 2m39s
[11:48:05.641] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:53:0)
[11:48:05.689] Build status: STARTED
[11:48:05.689] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:54:0) after 9m43s
[11:57:48.926] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:54:0)
[11:57:48.948] Build status: STARTED
[11:57:48.948] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:55:0) after 9m41s
[12:07:30.181] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:55:0)
[12:07:30.203] Build status: STARTED
[12:07:30.203] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:56:0) after 6m22s
[12:13:52.306] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:56:0)
[12:13:52.328] Build status: STARTED
[12:13:52.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:57:0) after 6m38s
[12:20:30.355] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:57:0)
[12:20:30.375] Build status: STARTED
[12:20:30.375] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8948744249770496928:58:0) after 7m4s
[12:25:19.213] Received PubSub notification, asking Buildbucket for the build status
[12:25:19.253] Build:
{
"id": "8783314187802417297",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11736,
"createdBy": "project:infra",
"createTime": "2023-04-20T07:31:08.374578236Z",
"startTime": "2023-04-20T07:31:44.102689Z",
"endTime": "2023-04-20T12:25:18.919126039Z",
"updateTime": "2023-04-20T12:25:18.919126039Z",
"status": "SUCCESS",
"input": {
}
}
[12:25:19.253] Invocation finished in 4h54m12.139876513s with status SUCCEEDED