[20:53:02.741] New invocation is queued and will start shortly
[20:53:02.741] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[20:53:03.843] Starting the invocation (attempt 1)
[20:53:03.906] Ignoring gitiles_ref tag without the buildset tag
[20:53:03.906] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:53:03.906] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:53:03.906] Buildbucket request:
{
"requestId": "8949962154419942848",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8949962154419942848",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "d6704bec1c9d660c15bf08875ed3d6eebdbc4e04",
"codesearch_mirror_revision_timestamp": 1680796498,
"root_solution_revision": "0968bb76980381e7950a483d8d20a00e4ac99bab",
"root_solution_revision_timestamp": 1680796270
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17062",
"user_agent:recipe"
]
},
"id": "44363ff8-adf3-428e-a2b8-f465480be7a7",
"title": "codesearch-gen-chromium-initiator/17062"
},
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "ec824be341a8227f71a2f37d6775079d5aaf7096",
"codesearch_mirror_revision_timestamp": 1680811076,
"root_solution_revision": "c57c19ee63f11604e4bcbea65fff90e93d757000",
"root_solution_revision_timestamp": 1680810897
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17063",
"user_agent:recipe"
]
},
"id": "ec9f55bb-a0df-4a47-a480-d0d6b73995d9",
"title": "codesearch-gen-chromium-initiator/17063"
}
]
},
"codesearch_mirror_revision": "ec824be341a8227f71a2f37d6775079d5aaf7096",
"codesearch_mirror_revision_timestamp": 1680811076,
"root_solution_revision": "c57c19ee63f11604e4bcbea65fff90e93d757000",
"root_solution_revision_timestamp": 1680810897
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949962154419942848"
},
{
"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": "17063"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:53:04.339] Scheduled build:
{
"id": "8784532092440664833",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11667,
"createdBy": "project:infra",
"createTime": "2023-04-06T20:53:04.000759833Z",
"updateTime": "2023-04-06T20:53:04.000759833Z",
"status": "SCHEDULED",
"input": {
}
}
[20:53:04.339] Task URL: https://cr-buildbucket.appspot.com/build/8784532092440664833
[20:53:04.339] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:2:0) after 9m0s
[20:53:23.266] Received PubSub notification, asking Buildbucket for the build status
[20:53:23.313] Build status: STARTED
[21:02:04.564] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:2:0)
[21:02:04.598] Build status: STARTED
[21:02:04.598] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:4:0) after 8m4s
[21:10:08.779] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:4:0)
[21:10:08.801] Build status: STARTED
[21:10:08.801] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:5:0) after 3m9s
[21:13:17.817] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:5:0)
[21:13:17.846] Build status: STARTED
[21:13:17.846] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:6:0) after 5m39s
[21:18:56.985] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:6:0)
[21:18:57.011] Build status: STARTED
[21:18:57.011] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:7:0) after 3m46s
[21:22:43.412] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:7:0)
[21:22:43.435] Build status: STARTED
[21:22:43.435] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:8:0) after 1m21s
[21:24:04.595] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:8:0)
[21:24:04.616] Build status: STARTED
[21:24:04.616] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:9:0) after 2m5s
[21:26:09.643] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:9:0)
[21:26:09.666] Build status: STARTED
[21:26:09.666] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:10:0) after 6m52s
[21:33:01.787] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:10:0)
[21:33:01.813] Build status: STARTED
[21:33:01.813] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:11:0) after 6m8s
[21:39:10.059] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:11:0)
[21:39:10.078] Build status: STARTED
[21:39:10.078] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:12:0) after 2m2s
[21:41:12.268] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:12:0)
[21:41:12.377] Build status: STARTED
[21:41:12.378] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:13:0) after 8m44s
[21:49:56.522] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:13:0)
[21:49:56.552] Build status: STARTED
[21:49:56.552] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:14:0) after 8m33s
[21:58:30.007] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:14:0)
[21:58:30.030] Build status: STARTED
[21:58:30.030] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:15:0) after 9m52s
[22:08:22.053] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:15:0)
[22:08:22.079] Build status: STARTED
[22:08:22.079] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:16:0) after 2m32s
[22:10:54.123] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:16:0)
[22:10:54.153] Build status: STARTED
[22:10:54.153] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:17:0) after 7m3s
[22:17:57.184] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:17:0)
[22:17:57.209] Build status: STARTED
[22:17:57.209] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:18:0) after 6m40s
[22:24:37.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:18:0)
[22:24:37.616] Build status: STARTED
[22:24:37.616] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:19:0) after 4m48s
[22:29:25.754] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:19:0)
[22:29:25.851] Build status: STARTED
[22:29:25.851] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:20:0) after 7m6s
[22:36:31.869] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:20:0)
[22:36:31.899] Build status: STARTED
[22:36:31.899] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:21:0) after 3m36s
[22:40:08.017] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:21:0)
[22:40:08.037] Build status: STARTED
[22:40:08.037] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:22:0) after 2m20s
[22:42:28.260] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:22:0)
[22:42:28.297] Build status: STARTED
[22:42:28.297] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:23:0) after 7m43s
[22:50:11.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:23:0)
[22:50:11.454] Build status: STARTED
[22:50:11.454] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:24:0) after 4m20s
[22:54:31.760] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:24:0)
[22:54:31.808] Build status: STARTED
[22:54:31.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:25:0) after 5m9s
[22:59:41.398] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:25:0)
[22:59:41.427] Build status: STARTED
[22:59:41.427] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:26:0) after 9m5s
[23:08:46.563] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:26:0)
[23:08:46.591] Build status: STARTED
[23:08:46.591] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:27:0) after 2m10s
[23:10:56.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:27:0)
[23:10:56.751] Build status: STARTED
[23:10:56.751] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:28:0) after 8m21s
[23:19:17.938] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:28:0)
[23:19:17.962] Build status: STARTED
[23:19:17.963] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:29:0) after 2m15s
[23:21:32.998] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:29:0)
[23:21:33.054] Build status: STARTED
[23:21:33.054] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:30:0) after 9m51s
[23:31:24.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:30:0)
[23:31:24.261] Build status: STARTED
[23:31:24.261] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:31:0) after 9m15s
[23:40:39.329] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:31:0)
[23:40:39.357] Build status: STARTED
[23:40:39.357] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:32:0) after 7m3s
[23:47:42.490] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:32:0)
[23:47:42.524] Build status: STARTED
[23:47:42.524] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:33:0) after 4m13s
[23:51:55.817] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:33:0)
[23:51:55.849] Build status: STARTED
[23:51:55.849] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:34:0) after 6m48s
[23:58:43.870] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:34:0)
[23:58:43.890] Build status: STARTED
[23:58:43.890] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:35:0) after 3m58s
[00:02:42.082] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:35:0)
[00:02:42.182] Build status: STARTED
[00:02:42.182] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:36:0) after 8m32s
[00:11:14.202] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:36:0)
[00:11:14.225] Build status: STARTED
[00:11:14.225] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:37:0) after 2m19s
[00:13:33.545] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:37:0)
[00:13:33.570] Build status: STARTED
[00:13:33.570] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:38:0) after 2m39s
[00:16:12.687] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:38:0)
[00:16:12.714] Build status: STARTED
[00:16:12.715] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:39:0) after 1m15s
[00:17:28.461] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:39:0)
[00:17:28.482] Build status: STARTED
[00:17:28.482] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:40:0) after 3m29s
[00:20:57.625] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:40:0)
[00:20:57.649] Build status: STARTED
[00:20:57.649] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:41:0) after 8m51s
[00:29:48.674] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:41:0)
[00:29:48.701] Build status: STARTED
[00:29:48.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:42:0) after 8m53s
[00:38:42.021] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:42:0)
[00:38:42.045] Build status: STARTED
[00:38:42.045] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:43:0) after 1m37s
[00:40:19.177] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:43:0)
[00:40:19.196] Build status: STARTED
[00:40:19.196] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:44:0) after 2m29s
[00:42:48.650] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:44:0)
[00:42:48.671] Build status: STARTED
[00:42:48.671] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:45:0) after 9m36s
[00:52:24.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:45:0)
[00:52:24.759] Build status: STARTED
[00:52:24.759] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:46:0) after 8m16s
[01:00:40.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:46:0)
[01:00:40.951] Build status: STARTED
[01:00:40.951] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:47:0) after 4m21s
[01:05:01.969] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:47:0)
[01:05:01.996] Build status: STARTED
[01:05:01.996] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:48:0) after 3m16s
[01:08:18.014] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:48:0)
[01:08:18.081] Build status: STARTED
[01:08:18.081] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:49:0) after 7m43s
[01:16:01.200] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:49:0)
[01:16:01.229] Build status: STARTED
[01:16:01.229] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:50:0) after 3m31s
[01:19:32.389] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:50:0)
[01:19:32.422] Build status: STARTED
[01:19:32.422] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:51:0) after 1m23s
[01:20:55.461] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:51:0)
[01:20:55.505] Build status: STARTED
[01:20:55.505] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:52:0) after 8m10s
[01:29:05.600] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:52:0)
[01:29:05.633] Build status: STARTED
[01:29:05.633] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:53:0) after 1m40s
[01:30:45.749] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:53:0)
[01:30:45.772] Build status: STARTED
[01:30:45.772] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:54:0) after 3m51s
[01:34:36.986] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:54:0)
[01:34:37.013] Build status: STARTED
[01:34:37.013] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:55:0) after 4m23s
[01:39:00.033] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:55:0)
[01:39:00.056] Build status: STARTED
[01:39:00.056] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:56:0) after 6m2s
[01:45:02.084] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:56:0)
[01:45:02.108] Build status: STARTED
[01:45:02.108] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:57:0) after 6m54s
[01:51:56.247] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:57:0)
[01:51:56.292] Build status: STARTED
[01:51:56.292] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:58:0) after 2m54s
[01:54:50.443] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:58:0)
[01:54:50.480] Build status: STARTED
[01:54:50.480] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:59:0) after 9m21s
[02:04:11.452] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:59:0)
[02:04:11.480] Build status: STARTED
[02:04:11.481] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8949962154419942848:60:0) after 5m59s
[02:07:49.641] Received PubSub notification, asking Buildbucket for the build status
[02:07:49.695] Build:
{
"id": "8784532092440664833",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11667,
"createdBy": "project:infra",
"createTime": "2023-04-06T20:53:04.000759833Z",
"startTime": "2023-04-06T20:53:22.664112Z",
"endTime": "2023-04-07T02:07:49.341087609Z",
"updateTime": "2023-04-07T02:07:49.341087609Z",
"status": "SUCCESS",
"input": {
}
}
[02:07:49.695] Invocation finished in 5h14m46.965488505s with status SUCCEEDED