[09:31:46.142] New invocation is queued and will start shortly
[09:31:46.142] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[09:31:47.241] Starting the invocation (attempt 1)
[09:31:47.265] Ignoring gitiles_ref tag without the buildset tag
[09:31:47.265] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:31:47.265] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:31:47.265] Buildbucket request:
{
"requestId": "8923913090311310432",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8923913090311310432",
"job": "infra/codesearch-gen-chromium-chromiumos",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "ac60160a75602c0c80f8369a87a9e8242ad64431",
"codesearch_mirror_revision_timestamp": 1705650794,
"root_solution_revision": "6c619b2f1880f77350f77bddc0a829828e272543",
"root_solution_revision_timestamp": 1705650580
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:18789",
"user_agent:recipe"
]
},
"id": "51e0f0ca-a3f6-42aa-b261-3b78a68a2eed",
"title": "codesearch-gen-chromium-initiator/18789"
}
]
},
"codesearch_mirror_revision": "ac60160a75602c0c80f8369a87a9e8242ad64431",
"codesearch_mirror_revision_timestamp": 1705650794,
"root_solution_revision": "6c619b2f1880f77350f77bddc0a829828e272543",
"root_solution_revision_timestamp": 1705650580
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8923913090311310432"
},
{
"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": "18789"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:31:48.331] Scheduled build:
{
"id": "8758483028289394865",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"number": 16133,
"createdBy": "project:infra",
"createTime": "2024-01-19T09:31:47.448125794Z",
"updateTime": "2024-01-19T09:31:47.448125794Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[09:31:48.331] Task URL: https://cr-buildbucket.appspot.com/build/8758483028289394865
[09:31:48.331] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:2:0) after 8m13s
[09:31:48.638] Received PubSub notification, asking Buildbucket for the build status
[09:31:48.656] Build status: SCHEDULED
[09:31:56.053] Received PubSub notification, asking Buildbucket for the build status
[09:31:56.129] Build status: STARTED
[09:40:01.355] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:2:0)
[09:40:01.374] Build status: STARTED
[09:40:01.374] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:5:0) after 6m23s
[09:46:24.460] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:5:0)
[09:46:24.488] Build status: STARTED
[09:46:24.488] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:6:0) after 3m41s
[09:50:05.624] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:6:0)
[09:50:05.679] Build status: STARTED
[09:50:05.679] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:7:0) after 3m23s
[09:53:28.693] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:7:0)
[09:53:28.719] Build status: STARTED
[09:53:28.719] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:8:0) after 9m9s
[10:02:37.735] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:8:0)
[10:02:37.749] Build status: STARTED
[10:02:37.749] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:9:0) after 6m46s
[10:09:23.762] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:9:0)
[10:09:23.824] Build status: STARTED
[10:09:23.824] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:10:0) after 1m14s
[10:10:37.840] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:10:0)
[10:10:38.017] Build status: STARTED
[10:10:38.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:11:0) after 7m54s
[10:18:32.045] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:11:0)
[10:18:32.077] Build status: STARTED
[10:18:32.077] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:12:0) after 9m55s
[10:28:27.301] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:12:0)
[10:28:27.331] Build status: STARTED
[10:28:27.332] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:13:0) after 8m3s
[10:36:30.343] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:13:0)
[10:36:30.372] Build status: STARTED
[10:36:30.372] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:14:0) after 1m35s
[10:38:05.479] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:14:0)
[10:38:05.513] Build status: STARTED
[10:38:05.513] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:15:0) after 2m35s
[10:40:40.719] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:15:0)
[10:40:40.746] Build status: STARTED
[10:40:40.746] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:16:0) after 2m13s
[10:42:53.801] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:16:0)
[10:42:53.823] Build status: STARTED
[10:42:53.823] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:17:0) after 4m20s
[10:47:13.921] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:17:0)
[10:47:14.015] Build status: STARTED
[10:47:14.015] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:18:0) after 8m2s
[10:55:16.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:18:0)
[10:55:16.046] Build status: STARTED
[10:55:16.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:19:0) after 8m18s
[11:03:34.062] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:19:0)
[11:03:34.094] Build status: STARTED
[11:03:34.094] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:20:0) after 9m2s
[11:12:36.234] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:20:0)
[11:12:36.265] Build status: STARTED
[11:12:36.265] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:21:0) after 2m58s
[11:15:34.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:21:0)
[11:15:34.543] Build status: STARTED
[11:15:34.544] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:22:0) after 8m14s
[11:23:48.804] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:22:0)
[11:23:48.824] Build status: STARTED
[11:23:48.825] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:23:0) after 8m7s
[11:31:55.921] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:23:0)
[11:31:55.943] Build status: STARTED
[11:31:55.943] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:24:0) after 8m3s
[11:39:59.179] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:24:0)
[11:39:59.205] Build status: STARTED
[11:39:59.205] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:25:0) after 6m32s
[11:46:31.628] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:25:0)
[11:46:31.656] Build status: STARTED
[11:46:31.656] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:26:0) after 7m0s
[11:53:31.859] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:26:0)
[11:53:31.877] Build status: STARTED
[11:53:31.877] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:27:0) after 5m15s
[11:58:47.020] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:27:0)
[11:58:47.042] Build status: STARTED
[11:58:47.042] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:28:0) after 2m53s
[12:01:40.187] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:28:0)
[12:01:40.211] Build status: STARTED
[12:01:40.211] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:29:0) after 1m30s
[12:03:10.329] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:29:0)
[12:03:10.368] Build status: STARTED
[12:03:10.368] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:30:0) after 2m48s
[12:05:58.365] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:30:0)
[12:05:58.390] Build status: STARTED
[12:05:58.390] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:31:0) after 6m42s
[12:12:40.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:31:0)
[12:12:40.432] Build status: STARTED
[12:12:40.432] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:32:0) after 5m55s
[12:18:35.456] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:32:0)
[12:18:35.478] Build status: STARTED
[12:18:35.478] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:33:0) after 1m19s
[12:19:54.577] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:33:0)
[12:19:54.678] Build status: STARTED
[12:19:54.678] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:34:0) after 1m11s
[12:21:05.707] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:34:0)
[12:21:05.725] Build status: STARTED
[12:21:05.725] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:35:0) after 1m22s
[12:22:27.741] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:35:0)
[12:22:27.774] Build status: STARTED
[12:22:27.774] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:36:0) after 4m7s
[12:26:35.307] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:36:0)
[12:26:35.385] Build status: STARTED
[12:26:35.385] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:37:0) after 3m31s
[12:30:06.491] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:37:0)
[12:30:06.513] Build status: STARTED
[12:30:06.513] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:38:0) after 1m23s
[12:31:29.663] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:38:0)
[12:31:29.729] Build status: STARTED
[12:31:29.729] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:39:0) after 6m55s
[12:38:24.847] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:39:0)
[12:38:24.894] Build status: STARTED
[12:38:24.894] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:40:0) after 3m16s
[12:41:40.916] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:40:0)
[12:41:40.949] Build status: STARTED
[12:41:40.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:41:0) after 1m40s
[12:43:20.925] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:41:0)
[12:43:20.942] Build status: STARTED
[12:43:20.942] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:42:0) after 3m53s
[12:47:13.910] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:42:0)
[12:47:13.939] Build status: STARTED
[12:47:13.939] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:43:0) after 1m5s
[12:48:19.146] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:43:0)
[12:48:19.246] Build status: STARTED
[12:48:19.246] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:44:0) after 4m43s
[12:53:02.269] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:44:0)
[12:53:02.291] Build status: STARTED
[12:53:02.291] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:45:0) after 2m18s
[12:55:20.374] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:45:0)
[12:55:20.401] Build status: STARTED
[12:55:20.401] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:46:0) after 8m7s
[13:03:27.427] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:46:0)
[13:03:27.452] Build status: STARTED
[13:03:27.452] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:47:0) after 1m25s
[13:04:52.475] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:47:0)
[13:04:52.506] Build status: STARTED
[13:04:52.506] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:48:0) after 4m51s
[13:09:43.679] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:48:0)
[13:09:43.701] Build status: STARTED
[13:09:43.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:49:0) after 8m33s
[13:18:16.742] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:49:0)
[13:18:16.829] Build status: STARTED
[13:18:16.829] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:8923913090311310432:50:0) after 4m55s
[13:22:20.085] Received PubSub notification, asking Buildbucket for the build status
[13:22:20.121] Build:
{
"id": "8758483028289394865",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-chromiumos"
},
"number": 16133,
"createdBy": "project:infra",
"createTime": "2024-01-19T09:31:47.448125794Z",
"startTime": "2024-01-19T09:31:55.082186415Z",
"endTime": "2024-01-19T13:22:19.620610606Z",
"updateTime": "2024-01-19T13:22:19.620610606Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[13:22:20.121] Invocation finished in 3h50m33.984494438s with status SUCCEEDED