[04:17:54.051] New invocation is queued and will start shortly
[04:17:54.051] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[04:17:55.197] Starting the invocation (attempt 1)
[04:17:55.230] Ignoring gitiles_ref tag without the buildset tag
[04:17:55.230] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:17:55.230] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:17:55.230] Buildbucket request:
{
"requestId": "8969956096120986880",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8969956096120986880",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "05224b0d22e302ba5bcf1b83271c4fef5d6414e9",
"codesearch_mirror_revision_timestamp": 1661745193,
"root_solution_revision": "0dc73085e763df6f6ac73d20b3b32e51fe68b0c5",
"root_solution_revision_timestamp": 1661744837
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15739",
"user_agent:recipe"
]
},
"id": "fb481ae3-9514-4301-a6e3-c9a7f5f122e0",
"title": "codesearch-gen-chromium-initiator/15739"
}
]
},
"codesearch_mirror_revision": "05224b0d22e302ba5bcf1b83271c4fef5d6414e9",
"codesearch_mirror_revision_timestamp": 1661745193,
"root_solution_revision": "0dc73085e763df6f6ac73d20b3b32e51fe68b0c5",
"root_solution_revision_timestamp": 1661744837
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8969956096120986880"
},
{
"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": "15739"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:17:55.674] Scheduled build:
{
"id": "8804526034182809969",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 10441,
"createdBy": "project:infra",
"createTime": "2022-08-29T04:17:55.277299592Z",
"updateTime": "2022-08-29T04:17:55.277299592Z",
"status": "SCHEDULED",
"input": {
}
}
[04:17:55.674] Task URL: https://cr-buildbucket.appspot.com/build/8804526034182809969
[04:17:55.674] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:2:0) after 2m41s
[04:18:24.422] Received PubSub notification, asking Buildbucket for the build status
[04:18:24.446] Build status: STARTED
[04:20:36.798] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:2:0)
[04:20:36.821] Build status: STARTED
[04:20:36.821] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:4:0) after 1m5s
[04:21:41.837] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:4:0)
[04:21:41.857] Build status: STARTED
[04:21:41.857] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:5:0) after 1m14s
[04:22:55.976] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:5:0)
[04:22:56.002] Build status: STARTED
[04:22:56.002] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:6:0) after 5m58s
[04:28:54.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:6:0)
[04:28:54.256] Build status: STARTED
[04:28:54.256] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:7:0) after 4m30s
[04:33:24.303] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:7:0)
[04:33:24.325] Build status: STARTED
[04:33:24.325] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:8:0) after 1m44s
[04:35:08.510] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:8:0)
[04:35:08.531] Build status: STARTED
[04:35:08.531] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:9:0) after 5m12s
[04:40:20.657] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:9:0)
[04:40:20.683] Build status: STARTED
[04:40:20.683] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:10:0) after 9m12s
[04:49:32.880] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:10:0)
[04:49:32.926] Build status: STARTED
[04:49:32.926] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:11:0) after 9m48s
[04:59:21.254] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:11:0)
[04:59:21.279] Build status: STARTED
[04:59:21.279] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:12:0) after 7m6s
[05:06:27.279] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:12:0)
[05:06:27.307] Build status: STARTED
[05:06:27.307] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:13:0) after 6m43s
[05:13:10.328] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:13:0)
[05:13:10.396] Build status: STARTED
[05:13:10.396] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:14:0) after 2m10s
[05:15:20.635] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:14:0)
[05:15:20.660] Build status: STARTED
[05:15:20.660] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:15:0) after 5m53s
[05:21:13.872] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:15:0)
[05:21:13.944] Build status: STARTED
[05:21:13.944] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:16:0) after 4m31s
[05:25:45.061] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:16:0)
[05:25:45.113] Build status: STARTED
[05:25:45.113] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:17:0) after 5m1s
[05:30:46.240] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:17:0)
[05:30:46.268] Build status: STARTED
[05:30:46.268] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:18:0) after 6m18s
[05:37:04.290] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:18:0)
[05:37:04.315] Build status: STARTED
[05:37:04.315] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:19:0) after 4m17s
[05:41:21.468] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:19:0)
[05:41:21.497] Build status: STARTED
[05:41:21.497] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:20:0) after 6m7s
[05:47:28.513] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:20:0)
[05:47:28.540] Build status: STARTED
[05:47:28.540] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:21:0) after 2m5s
[05:49:33.554] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:21:0)
[05:49:33.580] Build status: STARTED
[05:49:33.580] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:22:0) after 3m33s
[05:53:06.715] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:22:0)
[05:53:06.746] Build status: STARTED
[05:53:06.746] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:23:0) after 8m54s
[06:02:01.008] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:23:0)
[06:02:01.048] Build status: STARTED
[06:02:01.048] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:24:0) after 8m4s
[06:10:05.221] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:24:0)
[06:10:05.251] Build status: STARTED
[06:10:05.251] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:25:0) after 1m40s
[06:11:45.268] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:25:0)
[06:11:45.293] Build status: STARTED
[06:11:45.293] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:26:0) after 7m39s
[06:19:24.318] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:26:0)
[06:19:24.342] Build status: STARTED
[06:19:24.342] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:27:0) after 3m6s
[06:22:30.374] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:27:0)
[06:22:30.399] Build status: STARTED
[06:22:30.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:28:0) after 6m0s
[06:28:30.426] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:28:0)
[06:28:30.467] Build status: STARTED
[06:28:30.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:29:0) after 9m54s
[06:38:24.495] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:29:0)
[06:38:24.519] Build status: STARTED
[06:38:24.519] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:30:0) after 4m31s
[06:42:55.616] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:30:0)
[06:42:55.641] Build status: STARTED
[06:42:55.641] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:31:0) after 2m40s
[06:45:35.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:31:0)
[06:45:35.854] Build status: STARTED
[06:45:35.854] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:32:0) after 1m38s
[06:47:13.883] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:32:0)
[06:47:13.921] Build status: STARTED
[06:47:13.921] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:33:0) after 9m11s
[06:56:25.006] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:33:0)
[06:56:25.079] Build status: STARTED
[06:56:25.079] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:34:0) after 4m16s
[07:00:41.324] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:34:0)
[07:00:41.348] Build status: STARTED
[07:00:41.349] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:35:0) after 7m46s
[07:08:27.688] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:35:0)
[07:08:27.720] Build status: STARTED
[07:08:27.720] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:36:0) after 1m21s
[07:09:48.845] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:36:0)
[07:09:48.886] Build status: STARTED
[07:09:48.886] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:37:0) after 5m41s
[07:15:29.906] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:37:0)
[07:15:29.938] Build status: STARTED
[07:15:29.938] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:38:0) after 2m29s
[07:17:59.194] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:38:0)
[07:17:59.235] Build status: STARTED
[07:17:59.236] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:39:0) after 6m3s
[07:24:02.340] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:39:0)
[07:24:02.370] Build status: STARTED
[07:24:02.371] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:40:0) after 2m17s
[07:26:19.437] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:40:0)
[07:26:19.466] Build status: STARTED
[07:26:19.466] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:41:0) after 1m15s
[07:27:34.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:41:0)
[07:27:34.527] Build status: STARTED
[07:27:34.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:42:0) after 5m33s
[07:33:07.929] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:42:0)
[07:33:07.973] Build status: STARTED
[07:33:07.973] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:43:0) after 2m16s
[07:35:23.990] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:43:0)
[07:35:24.086] Build status: STARTED
[07:35:24.086] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:44:0) after 7m59s
[07:43:23.383] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:44:0)
[07:43:23.408] Build status: STARTED
[07:43:23.408] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:45:0) after 1m28s
[07:44:51.697] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:45:0)
[07:44:51.723] Build status: STARTED
[07:44:51.724] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:46:0) after 3m38s
[07:48:29.745] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:46:0)
[07:48:29.769] Build status: STARTED
[07:48:29.769] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8969956096120986880:47:0) after 9m35s
[07:52:11.267] Received PubSub notification, asking Buildbucket for the build status
[07:52:11.290] Build:
{
"id": "8804526034182809969",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 10441,
"createdBy": "project:infra",
"createTime": "2022-08-29T04:17:55.277299592Z",
"startTime": "2022-08-29T04:18:23.605295Z",
"endTime": "2022-08-29T07:52:10.875927332Z",
"updateTime": "2022-08-29T07:52:10.875927332Z",
"status": "SUCCESS",
"input": {
}
}
[07:52:11.290] Invocation finished in 3h34m17.245184805s with status SUCCEEDED