[00:01:02.931] New invocation is queued and will start shortly
[00:01:02.931] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[00:01:04.376] Starting the invocation (attempt 1)
[00:01:04.406] Ignoring gitiles_ref tag without the buildset tag
[00:01:04.406] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:01:04.407] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:01:04.407] Buildbucket request:
{
"requestId": "8944514508301376384",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8944514508301376384",
"job": "infra/codesearch-gen-chromium-chromiumos",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "83bb667a285cb8d2b53dfca28c1302f2edd6a38a",
"codesearch_mirror_revision_timestamp": 1686009445,
"root_solution_revision": "5940151d5670ed2adb977e1937d273d4992fb76d",
"root_solution_revision_timestamp": 1686009331
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17424",
"user_agent:recipe"
]
},
"id": "dcde8081-fd15-419e-9b10-195687849f31",
"title": "codesearch-gen-chromium-initiator/17424"
}
]
},
"codesearch_mirror_revision": "83bb667a285cb8d2b53dfca28c1302f2edd6a38a",
"codesearch_mirror_revision_timestamp": 1686009445,
"root_solution_revision": "5940151d5670ed2adb977e1937d273d4992fb76d",
"root_solution_revision_timestamp": 1686009331
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8944514508301376384"
},
{
"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": "17424"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:01:04.786] Scheduled build:
{
"id": "8779084446024138913",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"number": 14787,
"createdBy": "project:infra",
"createTime": "2023-06-06T00:01:04.473528519Z",
"updateTime": "2023-06-06T00:01:04.473528519Z",
"status": "SCHEDULED",
"input": {
}
}
[00:01:04.786] Task URL: https://cr-buildbucket.appspot.com/build/8779084446024138913
[00:01:04.786] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:2:0) after 3m3s
[00:01:46.502] Received PubSub notification, asking Buildbucket for the build status
[00:01:46.620] Build status: STARTED
[00:04:08.002] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:2:0)
[00:04:08.051] Build status: STARTED
[00:04:08.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:4:0) after 9m40s
[00:13:48.097] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:4:0)
[00:13:48.140] Build status: STARTED
[00:13:48.140] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:5:0) after 3m10s
[00:16:58.640] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:5:0)
[00:16:58.656] Build status: STARTED
[00:16:58.656] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:6:0) after 5m6s
[00:22:04.880] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:6:0)
[00:22:04.901] Build status: STARTED
[00:22:04.901] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:7:0) after 4m31s
[00:26:35.922] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:7:0)
[00:26:35.939] Build status: STARTED
[00:26:35.939] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:8:0) after 5m5s
[00:31:41.295] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:8:0)
[00:31:41.314] Build status: STARTED
[00:31:41.314] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:9:0) after 3m22s
[00:35:03.735] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:9:0)
[00:35:03.754] Build status: STARTED
[00:35:03.754] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:10:0) after 3m17s
[00:38:21.109] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:10:0)
[00:38:21.126] Build status: STARTED
[00:38:21.126] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:11:0) after 4m5s
[00:42:26.150] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:11:0)
[00:42:26.169] Build status: STARTED
[00:42:26.169] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:12:0) after 7m10s
[00:49:36.162] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:12:0)
[00:49:36.203] Build status: STARTED
[00:49:36.203] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:13:0) after 2m18s
[00:51:54.257] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:13:0)
[00:51:54.292] Build status: STARTED
[00:51:54.292] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:14:0) after 1m2s
[00:52:56.628] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:14:0)
[00:52:56.667] Build status: STARTED
[00:52:56.667] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:15:0) after 4m9s
[00:57:05.883] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:15:0)
[00:57:05.913] Build status: STARTED
[00:57:05.913] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:16:0) after 9m35s
[01:06:40.932] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:16:0)
[01:06:40.956] Build status: STARTED
[01:06:40.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:17:0) after 6m8s
[01:12:49.247] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:17:0)
[01:12:49.277] Build status: STARTED
[01:12:49.277] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:18:0) after 7m30s
[01:20:19.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:18:0)
[01:20:19.506] Build status: STARTED
[01:20:19.506] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:19:0) after 1m5s
[01:21:24.629] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:19:0)
[01:21:24.657] Build status: STARTED
[01:21:24.657] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:20:0) after 3m56s
[01:25:20.944] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:20:0)
[01:25:21.017] Build status: STARTED
[01:25:21.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:21:0) after 2m21s
[01:27:42.031] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:21:0)
[01:27:42.048] Build status: STARTED
[01:27:42.048] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:22:0) after 9m2s
[01:36:44.309] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:22:0)
[01:36:44.341] Build status: STARTED
[01:36:44.341] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:23:0) after 8m36s
[01:45:20.360] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:23:0)
[01:45:20.442] Build status: STARTED
[01:45:20.442] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:24:0) after 8m19s
[01:53:39.554] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:24:0)
[01:53:39.668] Build status: STARTED
[01:53:39.668] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:25:0) after 8m45s
[02:02:24.684] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:25:0)
[02:02:24.706] Build status: STARTED
[02:02:24.706] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:26:0) after 5m24s
[02:07:48.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:26:0)
[02:07:48.750] Build status: STARTED
[02:07:48.750] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:27:0) after 8m57s
[02:16:45.864] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:27:0)
[02:16:45.896] Build status: STARTED
[02:16:45.896] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:28:0) after 9m14s
[02:25:59.892] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:28:0)
[02:25:59.916] Build status: STARTED
[02:25:59.916] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:29:0) after 8m37s
[02:34:36.930] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:29:0)
[02:34:36.982] Build status: STARTED
[02:34:36.983] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:30:0) after 5m32s
[02:40:09.001] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:30:0)
[02:40:09.025] Build status: STARTED
[02:40:09.025] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:31:0) after 3m6s
[02:43:15.019] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:31:0)
[02:43:15.039] Build status: STARTED
[02:43:15.039] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8944514508301376384:32:0) after 6m35s
[02:43:50.305] Received PubSub notification, asking Buildbucket for the build status
[02:43:50.325] Build:
{
"id": "8779084446024138913",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"number": 14787,
"createdBy": "project:infra",
"createTime": "2023-06-06T00:01:04.473528519Z",
"startTime": "2023-06-06T00:01:45.611537Z",
"endTime": "2023-06-06T02:43:49.823851141Z",
"updateTime": "2023-06-06T02:43:49.823851141Z",
"status": "SUCCESS",
"input": {
}
}
[02:43:50.325] Invocation finished in 2h42m47.40720926s with status SUCCEEDED