[04:00:46.408] New invocation is queued and will start shortly
[04:00:46.408] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[04:00:47.604] Starting the invocation (attempt 1)
[04:00:47.634] Ignoring gitiles_ref tag without the buildset tag
[04:00:47.634] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:47.635] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:47.636] Buildbucket request:
{
"requestId": "8910163175898356672",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910163175898356672",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "310f2595a80a557f61a7df7c44394cd839cec59e",
"codesearch_mirror_revision_timestamp": 1718759377,
"root_solution_revision": "315eebd5965730b74cd19b738020c0dc6e4d1f8c",
"root_solution_revision_timestamp": 1718759326
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:19700",
"user_agent:recipe"
]
},
"id": "8da46c7e-fca3-49a7-aa9f-63a8953af28f",
"title": "codesearch-gen-chromium-initiator/19700"
}
]
},
"codesearch_mirror_revision": "310f2595a80a557f61a7df7c44394cd839cec59e",
"codesearch_mirror_revision_timestamp": 1718759377,
"root_solution_revision": "315eebd5965730b74cd19b738020c0dc6e4d1f8c",
"root_solution_revision_timestamp": 1718759326
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910163175898356672"
},
{
"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": "19700"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:48.332] Scheduled build:
{
"id": "8744733113794970481",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 13943,
"createdBy": "project:infra",
"createTime": "2024-06-19T04:00:47.754965152Z",
"updateTime": "2024-06-19T04:00:47.754965152Z",
"status": "SCHEDULED",
"input": {
}
}
[04:00:48.332] Task URL: https://cr-buildbucket.appspot.com/build/8744733113794970481
[04:00:48.332] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:2:0) after 7m23s
[04:00:49.190] Received PubSub notification, asking Buildbucket for the build status
[04:00:49.208] Build status: SCHEDULED
[04:00:54.892] Received PubSub notification, asking Buildbucket for the build status
[04:00:54.916] Build status: STARTED
[04:08:11.788] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:2:0)
[04:08:11.876] Build status: STARTED
[04:08:11.876] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:5:0) after 4m45s
[04:12:56.890] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:5:0)
[04:12:56.982] Build status: STARTED
[04:12:56.982] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:6:0) after 5m19s
[04:18:16.560] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:6:0)
[04:18:16.593] Build status: STARTED
[04:18:16.593] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:7:0) after 3m19s
[04:21:35.636] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:7:0)
[04:21:35.667] Build status: STARTED
[04:21:35.667] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:8:0) after 9m33s
[04:31:08.695] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:8:0)
[04:31:08.838] Build status: STARTED
[04:31:08.838] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:9:0) after 3m31s
[04:34:39.897] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:9:0)
[04:34:39.929] Build status: STARTED
[04:34:39.929] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:10:0) after 5m55s
[04:40:35.051] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:10:0)
[04:40:35.127] Build status: STARTED
[04:40:35.127] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:11:0) after 5m21s
[04:45:56.152] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:11:0)
[04:45:56.179] Build status: STARTED
[04:45:56.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:12:0) after 9m15s
[04:55:11.216] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:12:0)
[04:55:11.236] Build status: STARTED
[04:55:11.236] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:13:0) after 2m47s
[04:57:58.448] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:13:0)
[04:57:58.472] Build status: STARTED
[04:57:58.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:14:0) after 8m22s
[05:06:20.522] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:14:0)
[05:06:20.540] Build status: STARTED
[05:06:20.540] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:15:0) after 2m52s
[05:09:12.684] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:15:0)
[05:09:12.707] Build status: STARTED
[05:09:12.707] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:16:0) after 5m4s
[05:14:17.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:16:0)
[05:14:17.071] Build status: STARTED
[05:14:17.071] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:17:0) after 2m32s
[05:16:49.266] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:17:0)
[05:16:49.355] Build status: STARTED
[05:16:49.355] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:18:0) after 9m55s
[05:26:44.383] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:18:0)
[05:26:44.557] Build status: STARTED
[05:26:44.557] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:19:0) after 2m58s
[05:29:42.672] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:19:0)
[05:29:42.844] Build status: STARTED
[05:29:42.844] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:20:0) after 5m51s
[05:35:33.913] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:20:0)
[05:35:33.995] Build status: STARTED
[05:35:33.995] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:21:0) after 1m14s
[05:36:48.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:21:0)
[05:36:48.228] Build status: STARTED
[05:36:48.228] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:22:0) after 7m37s
[05:44:25.331] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:22:0)
[05:44:25.360] Build status: STARTED
[05:44:25.360] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:23:0) after 1m43s
[05:46:08.385] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:23:0)
[05:46:08.417] Build status: STARTED
[05:46:08.417] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:24:0) after 7m34s
[05:53:42.742] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:24:0)
[05:53:42.786] Build status: STARTED
[05:53:42.786] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:25:0) after 7m32s
[06:01:15.136] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:25:0)
[06:01:15.154] Build status: STARTED
[06:01:15.154] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:26:0) after 6m5s
[06:07:20.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:26:0)
[06:07:20.523] Build status: STARTED
[06:07:20.523] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:27:0) after 9m1s
[06:16:21.554] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:27:0)
[06:16:21.581] Build status: STARTED
[06:16:21.581] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:28:0) after 2m18s
[06:18:39.723] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:28:0)
[06:18:39.744] Build status: STARTED
[06:18:39.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:29:0) after 5m57s
[06:24:36.731] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:29:0)
[06:24:36.755] Build status: STARTED
[06:24:36.755] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:30:0) after 6m53s
[06:31:29.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:30:0)
[06:31:29.802] Build status: STARTED
[06:31:29.802] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:31:0) after 3m55s
[06:35:24.822] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:31:0)
[06:35:24.852] Build status: STARTED
[06:35:24.852] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:32:0) after 6m10s
[06:41:34.942] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:32:0)
[06:41:34.958] Build status: STARTED
[06:41:34.958] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:33:0) after 4m27s
[06:46:02.151] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:33:0)
[06:46:02.171] Build status: STARTED
[06:46:02.171] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8910163175898356672:34:0) after 8m1s
[06:47:05.676] Received PubSub notification, asking Buildbucket for the build status
[06:47:05.727] Build:
{
"id": "8744733113794970481",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 13943,
"createdBy": "project:infra",
"createTime": "2024-06-19T04:00:47.754965152Z",
"startTime": "2024-06-19T04:00:54.689574507Z",
"endTime": "2024-06-19T06:47:05.339642038Z",
"updateTime": "2024-06-19T06:47:05.339642038Z",
"status": "SUCCESS",
"input": {
}
}
[06:47:05.727] Invocation finished in 2h46m19.36272163s with status SUCCEEDED