[01:03:37.062] New invocation is queued and will start shortly
[01:03:37.062] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[01:03:38.623] Starting the invocation (attempt 1)
[01:03:38.663] Ignoring gitiles_ref tag without the buildset tag
[01:03:38.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:03:38.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:03:38.664] Buildbucket request:
{
"requestId": "8977940852412334688",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8977940852412334688",
"job": "infra/codesearch-gen-chromium-chromiumos",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "5dc0d421396d6d2eb1d3fdbb122f248bfd6bd1a4",
"codesearch_mirror_revision_timestamp": 1654127650,
"root_solution_revision": "2acbc5e254ba3583fcb476d67dbeff9387c2b9f8",
"root_solution_revision_timestamp": 1654127465
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15210",
"user_agent:recipe"
]
},
"id": "d03e0f35-d8a8-4fd5-83d7-c13fe39f4633",
"title": "codesearch-gen-chromium-initiator/15210"
}
]
},
"codesearch_mirror_revision": "5dc0d421396d6d2eb1d3fdbb122f248bfd6bd1a4",
"codesearch_mirror_revision_timestamp": 1654127650,
"root_solution_revision": "2acbc5e254ba3583fcb476d67dbeff9387c2b9f8",
"root_solution_revision_timestamp": 1654127465
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8977940852412334688"
},
{
"key": "scheduler_job_id",
"value": "infra/codesearch-gen-chromium-chromiumos"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "codesearch-gen-chromium-initiator"
},
{
"key": "parent_buildnumber",
"value": "15210"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:03:39.143] Scheduled build:
{
"id": "8812510789998083809",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"number": 12588,
"createdBy": "project:infra",
"createTime": "2022-06-02T01:03:38.733611873Z",
"updateTime": "2022-06-02T01:03:38.733611873Z",
"status": "SCHEDULED",
"input": {
}
}
[01:03:39.143] Task URL: https://cr-buildbucket.appspot.com/build/8812510789998083809
[01:03:39.143] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:2:0) after 3m31s
[01:04:14.322] Received PubSub notification, asking Buildbucket for the build status
[01:04:14.355] Build status: STARTED
[01:07:10.254] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:2:0)
[01:07:10.291] Build status: STARTED
[01:07:10.291] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:4:0) after 2m56s
[01:10:06.317] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:4:0)
[01:10:06.356] Build status: STARTED
[01:10:06.356] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:5:0) after 2m3s
[01:12:09.374] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:5:0)
[01:12:09.453] Build status: STARTED
[01:12:09.454] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:6:0) after 9m7s
[01:21:16.532] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:6:0)
[01:21:16.586] Build status: STARTED
[01:21:16.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:7:0) after 6m11s
[01:27:27.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:7:0)
[01:27:27.778] Build status: STARTED
[01:27:27.778] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:8:0) after 3m36s
[01:31:04.135] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:8:0)
[01:31:04.167] Build status: STARTED
[01:31:04.167] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:9:0) after 8m37s
[01:39:41.423] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:9:0)
[01:39:41.459] Build status: STARTED
[01:39:41.460] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:10:0) after 9m53s
[01:49:34.482] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:10:0)
[01:49:34.537] Build status: STARTED
[01:49:34.537] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:11:0) after 5m24s
[01:54:58.558] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:11:0)
[01:54:58.589] Build status: STARTED
[01:54:58.589] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:12:0) after 6m15s
[02:01:13.609] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:12:0)
[02:01:13.672] Build status: STARTED
[02:01:13.672] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:13:0) after 9m57s
[02:11:10.690] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:13:0)
[02:11:10.729] Build status: STARTED
[02:11:10.729] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:14:0) after 2m40s
[02:13:50.768] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:14:0)
[02:13:50.804] Build status: STARTED
[02:13:50.804] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:15:0) after 3m1s
[02:16:51.875] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:15:0)
[02:16:51.914] Build status: STARTED
[02:16:51.914] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:16:0) after 9m50s
[02:26:41.992] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:16:0)
[02:26:42.023] Build status: STARTED
[02:26:42.023] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:17:0) after 2m29s
[02:29:11.166] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:17:0)
[02:29:11.208] Build status: STARTED
[02:29:11.208] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:18:0) after 6m18s
[02:35:29.232] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:18:0)
[02:35:29.288] Build status: STARTED
[02:35:29.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:19:0) after 6m4s
[02:41:33.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:19:0)
[02:41:33.422] Build status: STARTED
[02:41:33.422] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:20:0) after 9m51s
[02:51:24.548] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:20:0)
[02:51:24.588] Build status: STARTED
[02:51:24.588] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:21:0) after 9m57s
[03:01:21.673] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:21:0)
[03:01:21.707] Build status: STARTED
[03:01:21.707] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:22:0) after 2m59s
[03:04:20.726] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:22:0)
[03:04:20.757] Build status: STARTED
[03:04:20.757] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:23:0) after 8m20s
[03:12:40.974] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:23:0)
[03:12:41.002] Build status: STARTED
[03:12:41.002] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:24:0) after 3m45s
[03:16:26.023] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:24:0)
[03:16:26.051] Build status: STARTED
[03:16:26.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:25:0) after 7m24s
[03:23:50.355] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:25:0)
[03:23:50.387] Build status: STARTED
[03:23:50.387] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:26:0) after 4m48s
[03:28:38.416] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:26:0)
[03:28:38.458] Build status: STARTED
[03:28:38.458] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:27:0) after 9m29s
[03:38:07.465] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:27:0)
[03:38:07.495] Build status: STARTED
[03:38:07.495] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:28:0) after 1m18s
[03:39:25.736] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:28:0)
[03:39:25.781] Build status: STARTED
[03:39:25.781] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:29:0) after 5m51s
[03:45:16.806] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:29:0)
[03:45:16.828] Build status: STARTED
[03:45:16.828] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:30:0) after 9m15s
[03:54:31.851] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:30:0)
[03:54:31.890] Build status: STARTED
[03:54:31.890] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:31:0) after 2m19s
[03:56:50.907] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:31:0)
[03:56:50.963] Build status: STARTED
[03:56:50.963] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:32:0) after 4m44s
[04:01:35.173] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:32:0)
[04:01:35.209] Build status: STARTED
[04:01:35.209] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:33:0) after 9m13s
[04:10:48.312] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:33:0)
[04:10:48.347] Build status: STARTED
[04:10:48.348] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:34:0) after 8m3s
[04:18:51.502] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:34:0)
[04:18:51.545] Build status: STARTED
[04:18:51.545] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:35:0) after 4m2s
[04:22:53.794] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:35:0)
[04:22:53.841] Build status: STARTED
[04:22:53.842] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:36:0) after 4m29s
[04:27:23.047] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:36:0)
[04:27:23.104] Build status: STARTED
[04:27:23.104] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:37:0) after 7m7s
[04:34:30.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:37:0)
[04:34:30.159] Build status: STARTED
[04:34:30.159] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:38:0) after 5m7s
[04:39:37.229] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:38:0)
[04:39:37.289] Build status: STARTED
[04:39:37.289] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:39:0) after 1m12s
[04:40:49.550] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:39:0)
[04:40:49.587] Build status: STARTED
[04:40:49.587] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:40:0) after 3m50s
[04:44:39.608] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:40:0)
[04:44:39.641] Build status: STARTED
[04:44:39.641] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:41:0) after 5m39s
[04:50:18.620] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:41:0)
[04:50:18.676] Build status: STARTED
[04:50:18.676] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:42:0) after 2m1s
[04:52:19.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:42:0)
[04:52:19.842] Build status: STARTED
[04:52:19.842] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:43:0) after 4m50s
[04:57:10.108] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:43:0)
[04:57:10.131] Build status: STARTED
[04:57:10.131] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:44:0) after 6m13s
[05:03:23.215] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:44:0)
[05:03:23.247] Build status: STARTED
[05:03:23.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:45:0) after 3m32s
[05:06:55.268] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:45:0)
[05:06:55.305] Build status: STARTED
[05:06:55.305] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:46:0) after 4m29s
[05:11:24.497] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:46:0)
[05:11:24.552] Build status: STARTED
[05:11:24.552] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:47:0) after 8m52s
[05:20:16.713] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:47:0)
[05:20:16.743] Build status: STARTED
[05:20:16.743] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:48:0) after 5m52s
[05:26:08.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:48:0)
[05:26:08.859] Build status: STARTED
[05:26:08.859] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8977940852412334688:49:0) after 9m49s
[05:30:37.679] Received PubSub notification, asking Buildbucket for the build status
[05:30:37.709] Build:
{
"id": "8812510789998083809",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"number": 12588,
"createdBy": "project:infra",
"createTime": "2022-06-02T01:03:38.733611873Z",
"startTime": "2022-06-02T01:04:12.817269Z",
"endTime": "2022-06-02T05:30:37.334056752Z",
"updateTime": "2022-06-02T05:30:37.334056752Z",
"status": "SUCCESS",
"input": {
}
}
[05:30:37.709] Invocation finished in 4h27m0.663062476s with status SUCCEEDED