[17:09:22.627] New invocation is queued and will start shortly
[17:09:22.627] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[17:09:23.901] Starting the invocation (attempt 1)
[17:09:23.944] Ignoring gitiles_ref tag without the buildset tag
[17:09:23.944] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:09:23.944] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:09:23.944] Buildbucket request:
{
"requestId": "8977427107251664080",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8977427107251664080",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "756db80f149c6564ee511ee9ebe8dd7193ea118e",
"codesearch_mirror_revision_timestamp": 1654617273,
"root_solution_revision": "a11a432ad28dcae41e5530ce1a234fe1493a2d50",
"root_solution_revision_timestamp": 1654617051
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15244",
"user_agent:recipe"
]
},
"id": "acc62c54-7c69-4ebb-a510-c64fa41d8dbf",
"title": "codesearch-gen-chromium-initiator/15244"
}
]
},
"codesearch_mirror_revision": "756db80f149c6564ee511ee9ebe8dd7193ea118e",
"codesearch_mirror_revision_timestamp": 1654617273,
"root_solution_revision": "a11a432ad28dcae41e5530ce1a234fe1493a2d50",
"root_solution_revision_timestamp": 1654617051
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8977427107251664080"
},
{
"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": "15244"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:09:24.452] Scheduled build:
{
"id": "8811997045130648561",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 9962,
"createdBy": "project:infra",
"createTime": "2022-06-07T17:09:24.019295021Z",
"updateTime": "2022-06-07T17:09:24.019295021Z",
"status": "SCHEDULED",
"input": {
}
}
[17:09:24.453] Task URL: https://cr-buildbucket.appspot.com/build/8811997045130648561
[17:09:24.453] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:2:0) after 4m4s
[17:13:29.142] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:2:0)
[17:13:29.253] Build status: SCHEDULED
[17:13:29.253] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:3:0) after 1m20s
[17:14:49.288] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:3:0)
[17:14:49.317] Build status: SCHEDULED
[17:14:49.317] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:4:0) after 7m52s
[17:15:01.524] Received PubSub notification, asking Buildbucket for the build status
[17:15:01.557] Build status: STARTED
[17:22:41.380] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:4:0)
[17:22:41.416] Build status: STARTED
[17:22:41.416] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:6:0) after 1m14s
[17:23:55.495] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:6:0)
[17:23:55.527] Build status: STARTED
[17:23:55.527] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:7:0) after 3m2s
[17:26:57.543] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:7:0)
[17:26:57.575] Build status: STARTED
[17:26:57.575] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:8:0) after 3m33s
[17:30:30.697] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:8:0)
[17:30:30.768] Build status: STARTED
[17:30:30.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:9:0) after 3m39s
[17:34:10.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:9:0)
[17:34:10.330] Build status: STARTED
[17:34:10.330] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:10:0) after 5m20s
[17:39:30.347] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:10:0)
[17:39:30.376] Build status: STARTED
[17:39:30.376] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:11:0) after 8m53s
[17:48:23.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:11:0)
[17:48:23.456] Build status: STARTED
[17:48:23.456] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:12:0) after 9m4s
[17:57:27.523] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:12:0)
[17:57:27.563] Build status: STARTED
[17:57:27.563] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:13:0) after 3m52s
[18:01:19.547] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:13:0)
[18:01:19.581] Build status: STARTED
[18:01:19.581] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:14:0) after 8m26s
[18:09:45.555] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:14:0)
[18:09:45.634] Build status: STARTED
[18:09:45.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:15:0) after 3m56s
[18:13:41.701] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:15:0)
[18:13:41.808] Build status: STARTED
[18:13:41.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:16:0) after 8m49s
[18:22:31.174] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:16:0)
[18:22:31.196] Build status: STARTED
[18:22:31.196] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:17:0) after 1m24s
[18:23:56.191] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:17:0)
[18:23:56.273] Build status: STARTED
[18:23:56.273] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:18:0) after 7m58s
[18:31:54.345] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:18:0)
[18:31:54.403] Build status: STARTED
[18:31:54.403] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:19:0) after 9m13s
[18:41:07.514] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:19:0)
[18:41:07.545] Build status: STARTED
[18:41:07.545] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:20:0) after 2m30s
[18:43:37.559] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:20:0)
[18:43:37.594] Build status: STARTED
[18:43:37.594] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:21:0) after 8m53s
[18:52:30.620] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:21:0)
[18:52:30.659] Build status: STARTED
[18:52:30.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:22:0) after 6m24s
[18:58:54.920] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:22:0)
[18:58:54.951] Build status: STARTED
[18:58:54.951] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:23:0) after 8m24s
[19:07:19.012] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:23:0)
[19:07:19.049] Build status: STARTED
[19:07:19.049] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:24:0) after 4m34s
[19:11:53.132] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:24:0)
[19:11:53.175] Build status: STARTED
[19:11:53.175] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:25:0) after 8m24s
[19:20:17.194] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:25:0)
[19:20:17.224] Build status: STARTED
[19:20:17.224] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:26:0) after 7m27s
[19:27:44.245] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:26:0)
[19:27:44.282] Build status: STARTED
[19:27:44.282] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:27:0) after 3m57s
[19:31:41.298] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:27:0)
[19:31:41.328] Build status: STARTED
[19:31:41.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:28:0) after 3m50s
[19:35:31.349] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:28:0)
[19:35:31.400] Build status: STARTED
[19:35:31.401] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:29:0) after 9m50s
[19:45:21.435] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:29:0)
[19:45:21.469] Build status: STARTED
[19:45:21.469] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:30:0) after 4m38s
[19:49:59.528] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:30:0)
[19:49:59.563] Build status: STARTED
[19:49:59.563] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:31:0) after 1m25s
[19:51:24.577] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:31:0)
[19:51:24.647] Build status: STARTED
[19:51:24.647] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:32:0) after 5m6s
[19:56:30.717] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:32:0)
[19:56:30.755] Build status: STARTED
[19:56:30.755] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:33:0) after 8m26s
[20:04:56.988] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:33:0)
[20:04:57.021] Build status: STARTED
[20:04:57.021] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:34:0) after 9m55s
[20:14:52.116] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:34:0)
[20:14:52.150] Build status: STARTED
[20:14:52.150] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:35:0) after 2m59s
[20:17:51.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:35:0)
[20:17:51.202] Build status: STARTED
[20:17:51.202] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8977427107251664080:36:0) after 9m15s
[20:22:27.937] Received PubSub notification, asking Buildbucket for the build status
[20:22:28.047] Build:
{
"id": "8811997045130648561",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 9962,
"createdBy": "project:infra",
"createTime": "2022-06-07T17:09:24.019295021Z",
"startTime": "2022-06-07T17:14:58.067702Z",
"endTime": "2022-06-07T20:22:27.664823165Z",
"updateTime": "2022-06-07T20:22:27.664823165Z",
"status": "SUCCESS",
"input": {
}
}
[20:22:28.047] Invocation finished in 3h13m5.434942257s with status SUCCEEDED