[23:49:32.102] New invocation is queued and will start shortly
[23:49:32.102] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[23:49:33.176] Starting the invocation (attempt 1)
[23:49:33.207] Ignoring gitiles_ref tag without the buildset tag
[23:49:33.207] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:49:33.207] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:49:33.207] Buildbucket request:
{
"requestId": "8945330605378034080",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8945330605378034080",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "559b47d35bda7bb458cf4725521dbfa7394a6237",
"codesearch_mirror_revision_timestamp": 1685216539,
"root_solution_revision": "fa2e0631628502e1eb56b48f3c4089fd338a98c7",
"root_solution_revision_timestamp": 1685216323
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17369",
"user_agent:recipe"
]
},
"id": "9ac45d4f-d1fb-4f48-a7d8-ebfdce6f0a25",
"title": "codesearch-gen-chromium-initiator/17369"
}
]
},
"codesearch_mirror_revision": "559b47d35bda7bb458cf4725521dbfa7394a6237",
"codesearch_mirror_revision_timestamp": 1685216539,
"root_solution_revision": "fa2e0631628502e1eb56b48f3c4089fd338a98c7",
"root_solution_revision_timestamp": 1685216323
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945330605378034080"
},
{
"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": "17369"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:49:33.559] Scheduled build:
{
"id": "8779900543495461393",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11923,
"createdBy": "project:infra",
"createTime": "2023-05-27T23:49:33.275901521Z",
"updateTime": "2023-05-27T23:49:33.275901521Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[23:49:33.559] Task URL: https://cr-buildbucket.appspot.com/build/8779900543495461393
[23:49:33.559] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:2:0) after 1m26s
[23:50:12.823] Received PubSub notification, asking Buildbucket for the build status
[23:50:12.840] Build status: STARTED
[23:50:59.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:2:0)
[23:50:59.631] Build status: STARTED
[23:50:59.631] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:4:0) after 6m32s
[23:57:31.705] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:4:0)
[23:57:31.729] Build status: STARTED
[23:57:31.729] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:5:0) after 1m56s
[23:59:27.842] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:5:0)
[23:59:27.867] Build status: STARTED
[23:59:27.867] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:6:0) after 4m14s
[00:03:41.985] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:6:0)
[00:03:42.048] Build status: STARTED
[00:03:42.048] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:7:0) after 8m59s
[00:12:41.063] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:7:0)
[00:12:41.132] Build status: STARTED
[00:12:41.132] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:8:0) after 1m12s
[00:13:53.146] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:8:0)
[00:13:53.164] Build status: STARTED
[00:13:53.164] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:9:0) after 7m38s
[00:21:31.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:9:0)
[00:21:31.233] Build status: STARTED
[00:21:31.233] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:10:0) after 3m46s
[00:25:17.246] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:10:0)
[00:25:17.315] Build status: STARTED
[00:25:17.315] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:11:0) after 6m38s
[00:31:55.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:11:0)
[00:31:55.444] Build status: STARTED
[00:31:55.444] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:12:0) after 6m13s
[00:38:08.651] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:12:0)
[00:38:08.680] Build status: STARTED
[00:38:08.680] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:13:0) after 8m26s
[00:46:34.906] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:13:0)
[00:46:34.923] Build status: STARTED
[00:46:34.923] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:14:0) after 6m40s
[00:53:15.037] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:14:0)
[00:53:15.073] Build status: STARTED
[00:53:15.073] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:15:0) after 8m10s
[01:01:25.088] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:15:0)
[01:01:25.122] Build status: STARTED
[01:01:25.122] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:16:0) after 3m35s
[01:05:00.455] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:16:0)
[01:05:00.491] Build status: STARTED
[01:05:00.491] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:17:0) after 8m47s
[01:13:47.517] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:17:0)
[01:13:47.533] Build status: STARTED
[01:13:47.533] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:18:0) after 4m32s
[01:18:19.548] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:18:0)
[01:18:19.568] Build status: STARTED
[01:18:19.568] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:19:0) after 9m38s
[01:27:57.782] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:19:0)
[01:27:57.816] Build status: STARTED
[01:27:57.816] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:20:0) after 7m36s
[01:35:33.837] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:20:0)
[01:35:33.868] Build status: STARTED
[01:35:33.868] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:21:0) after 6m15s
[01:41:48.895] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:21:0)
[01:41:48.916] Build status: STARTED
[01:41:48.916] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:22:0) after 7m0s
[01:48:48.933] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:22:0)
[01:48:48.961] Build status: STARTED
[01:48:48.961] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:23:0) after 4m42s
[01:53:31.585] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:23:0)
[01:53:31.614] Build status: STARTED
[01:53:31.614] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:24:0) after 5m9s
[01:58:40.645] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:24:0)
[01:58:40.672] Build status: STARTED
[01:58:40.672] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:25:0) after 2m34s
[02:01:14.690] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:25:0)
[02:01:14.743] Build status: STARTED
[02:01:14.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:26:0) after 2m38s
[02:03:52.716] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:26:0)
[02:03:52.735] Build status: STARTED
[02:03:52.735] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:27:0) after 4m55s
[02:08:48.022] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:27:0)
[02:08:48.042] Build status: STARTED
[02:08:48.042] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:28:0) after 7m1s
[02:15:49.057] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:28:0)
[02:15:49.113] Build status: STARTED
[02:15:49.113] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:29:0) after 1m28s
[02:17:17.131] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:29:0)
[02:17:17.158] Build status: STARTED
[02:17:17.158] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:30:0) after 1m52s
[02:19:09.278] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:30:0)
[02:19:09.295] Build status: STARTED
[02:19:09.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:31:0) after 5m0s
[02:24:09.310] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:31:0)
[02:24:09.331] Build status: STARTED
[02:24:09.331] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:32:0) after 5m31s
[02:29:40.374] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:32:0)
[02:29:40.396] Build status: STARTED
[02:29:40.397] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:33:0) after 3m47s
[02:33:27.627] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:33:0)
[02:33:27.661] Build status: STARTED
[02:33:27.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:34:0) after 8m51s
[02:42:18.807] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:34:0)
[02:42:18.838] Build status: STARTED
[02:42:18.838] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:35:0) after 2m46s
[02:45:04.845] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:35:0)
[02:45:04.864] Build status: STARTED
[02:45:04.864] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:36:0) after 4m57s
[02:50:02.005] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:36:0)
[02:50:02.107] Build status: STARTED
[02:50:02.107] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:37:0) after 3m33s
[02:53:35.131] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:37:0)
[02:53:35.160] Build status: STARTED
[02:53:35.160] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:38:0) after 1m11s
[02:54:46.353] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:38:0)
[02:54:46.394] Build status: STARTED
[02:54:46.394] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:39:0) after 2m11s
[02:56:57.532] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:39:0)
[02:56:57.641] Build status: STARTED
[02:56:57.641] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:40:0) after 4m40s
[03:01:37.779] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:40:0)
[03:01:37.800] Build status: STARTED
[03:01:37.800] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:41:0) after 5m1s
[03:06:38.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:41:0)
[03:06:38.902] Build status: STARTED
[03:06:38.902] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:42:0) after 8m46s
[03:15:24.923] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:42:0)
[03:15:24.945] Build status: STARTED
[03:15:24.945] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:43:0) after 2m12s
[03:17:36.975] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:43:0)
[03:17:37.035] Build status: STARTED
[03:17:37.035] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:44:0) after 7m20s
[03:24:57.055] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:44:0)
[03:24:57.148] Build status: STARTED
[03:24:57.148] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:45:0) after 7m7s
[03:32:04.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:45:0)
[03:32:04.425] Build status: STARTED
[03:32:04.425] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:46:0) after 8m14s
[03:40:18.536] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:46:0)
[03:40:18.599] Build status: STARTED
[03:40:18.601] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:47:0) after 1m14s
[03:41:32.765] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:47:0)
[03:41:32.793] Build status: STARTED
[03:41:32.793] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8945330605378034080:48:0) after 3m41s
[03:42:34.677] Received PubSub notification, asking Buildbucket for the build status
[03:42:34.695] Build:
{
"id": "8779900543495461393",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11923,
"createdBy": "project:infra",
"createTime": "2023-05-27T23:49:33.275901521Z",
"startTime": "2023-05-27T23:50:11.435889Z",
"endTime": "2023-05-28T03:42:34.302194746Z",
"updateTime": "2023-05-28T03:42:34.302194746Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[03:42:34.695] Invocation finished in 3h53m2.599723814s with status SUCCEEDED