[15:39:40.078] New invocation is queued and will start shortly
[15:39:40.078] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[15:39:41.727] Starting the invocation (attempt 1)
[15:39:41.755] Ignoring gitiles_ref tag without the buildset tag
[15:39:41.755] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:39:41.755] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:39:41.756] Buildbucket request:
{
"requestId": "8954330524822816880",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8954330524822816880",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "a7437bb24187482891b236c23db7fb4d4c9c0432",
"codesearch_mirror_revision_timestamp": 1676635143,
"root_solution_revision": "970f725bde596f933ac9c69affa6f753327a5bf6",
"root_solution_revision_timestamp": 1676634926
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:16773",
"user_agent:recipe"
]
},
"id": "51c6ef73-97ca-47d0-8a24-0574fe9e9ced",
"title": "codesearch-gen-chromium-initiator/16773"
}
]
},
"codesearch_mirror_revision": "a7437bb24187482891b236c23db7fb4d4c9c0432",
"codesearch_mirror_revision_timestamp": 1676635143,
"root_solution_revision": "970f725bde596f933ac9c69affa6f753327a5bf6",
"root_solution_revision_timestamp": 1676634926
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8954330524822816880"
},
{
"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": "16773"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:39:42.799] Scheduled build:
{
"id": "8788900462272725233",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11414,
"createdBy": "project:infra",
"createTime": "2023-02-17T15:39:41.887988057Z",
"updateTime": "2023-02-17T15:39:41.887988057Z",
"status": "SCHEDULED",
"input": {
}
}
[15:39:42.799] Task URL: https://cr-buildbucket.appspot.com/build/8788900462272725233
[15:39:42.799] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:2:0) after 8m57s
[15:40:19.264] Received PubSub notification, asking Buildbucket for the build status
[15:40:19.290] Build status: STARTED
[15:48:39.916] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:2:0)
[15:48:39.952] Build status: STARTED
[15:48:39.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:4:0) after 6m37s
[15:55:17.062] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:4:0)
[15:55:17.100] Build status: STARTED
[15:55:17.100] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:5:0) after 4m46s
[16:00:03.229] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:5:0)
[16:00:03.283] Build status: STARTED
[16:00:03.283] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:6:0) after 6m3s
[16:06:07.007] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:6:0)
[16:06:07.062] Build status: STARTED
[16:06:07.062] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:7:0) after 6m11s
[16:12:18.085] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:7:0)
[16:12:18.116] Build status: STARTED
[16:12:18.116] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:8:0) after 7m23s
[16:19:41.147] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:8:0)
[16:19:41.168] Build status: STARTED
[16:19:41.168] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:9:0) after 5m7s
[16:24:48.203] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:9:0)
[16:24:48.226] Build status: STARTED
[16:24:48.226] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:10:0) after 7m57s
[16:32:45.259] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:10:0)
[16:32:45.284] Build status: STARTED
[16:32:45.284] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:11:0) after 3m54s
[16:36:39.319] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:11:0)
[16:36:39.339] Build status: STARTED
[16:36:39.339] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:12:0) after 2m5s
[16:38:44.337] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:12:0)
[16:38:44.360] Build status: STARTED
[16:38:44.360] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:13:0) after 3m43s
[16:42:27.390] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:13:0)
[16:42:27.412] Build status: STARTED
[16:42:27.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:14:0) after 4m19s
[16:46:46.932] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:14:0)
[16:46:46.966] Build status: STARTED
[16:46:46.966] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:15:0) after 3m4s
[16:49:50.982] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:15:0)
[16:49:51.007] Build status: STARTED
[16:49:51.007] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:16:0) after 1m51s
[16:51:42.032] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:16:0)
[16:51:42.071] Build status: STARTED
[16:51:42.071] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:17:0) after 5m23s
[16:57:05.107] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:17:0)
[16:57:05.138] Build status: STARTED
[16:57:05.138] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:18:0) after 6m43s
[17:03:48.208] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:18:0)
[17:03:48.258] Build status: STARTED
[17:03:48.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:19:0) after 4m56s
[17:08:44.396] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:19:0)
[17:08:44.419] Build status: STARTED
[17:08:44.419] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:20:0) after 7m54s
[17:16:38.447] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:20:0)
[17:16:38.473] Build status: STARTED
[17:16:38.473] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:21:0) after 2m1s
[17:18:39.553] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:21:0)
[17:18:39.631] Build status: STARTED
[17:18:39.631] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:22:0) after 6m2s
[17:24:41.922] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:22:0)
[17:24:41.943] Build status: STARTED
[17:24:41.943] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:23:0) after 4m36s
[17:29:18.105] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:23:0)
[17:29:18.124] Build status: STARTED
[17:29:18.124] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:24:0) after 7m52s
[17:37:10.206] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:24:0)
[17:37:10.240] Build status: STARTED
[17:37:10.240] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:25:0) after 2m26s
[17:39:36.356] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:25:0)
[17:39:36.380] Build status: STARTED
[17:39:36.380] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:26:0) after 8m12s
[17:47:48.426] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:26:0)
[17:47:48.448] Build status: STARTED
[17:47:48.448] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:27:0) after 1m27s
[17:49:15.467] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:27:0)
[17:49:15.494] Build status: STARTED
[17:49:15.494] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:28:0) after 7m32s
[17:56:47.615] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:28:0)
[17:56:47.639] Build status: STARTED
[17:56:47.639] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:29:0) after 6m24s
[18:03:11.930] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:29:0)
[18:03:11.967] Build status: STARTED
[18:03:11.967] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:30:0) after 2m13s
[18:05:25.270] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:30:0)
[18:05:25.404] Build status: STARTED
[18:05:25.404] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:31:0) after 7m44s
[18:13:09.840] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:31:0)
[18:13:09.873] Build status: STARTED
[18:13:09.873] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:32:0) after 4m3s
[18:17:13.026] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:32:0)
[18:17:13.060] Build status: STARTED
[18:17:13.060] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:33:0) after 6m35s
[18:23:48.078] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:33:0)
[18:23:48.100] Build status: STARTED
[18:23:48.100] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:34:0) after 2m45s
[18:26:33.255] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:34:0)
[18:26:33.286] Build status: STARTED
[18:26:33.286] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:35:0) after 7m41s
[18:34:14.367] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:35:0)
[18:34:14.390] Build status: STARTED
[18:34:14.390] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:36:0) after 8m19s
[18:42:33.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:36:0)
[18:42:33.513] Build status: STARTED
[18:42:33.513] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:37:0) after 3m50s
[18:46:23.530] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:37:0)
[18:46:23.564] Build status: STARTED
[18:46:23.564] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:38:0) after 7m8s
[18:53:31.610] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:38:0)
[18:53:31.632] Build status: STARTED
[18:53:31.632] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:39:0) after 3m11s
[18:56:42.651] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:39:0)
[18:56:42.709] Build status: STARTED
[18:56:42.709] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:40:0) after 6m48s
[19:03:30.739] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:40:0)
[19:03:30.761] Build status: STARTED
[19:03:30.761] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:41:0) after 1m57s
[19:05:27.785] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:41:0)
[19:05:27.820] Build status: STARTED
[19:05:27.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:42:0) after 7m45s
[19:13:12.836] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:42:0)
[19:13:12.861] Build status: STARTED
[19:13:12.861] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:43:0) after 5m32s
[19:18:45.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:43:0)
[19:18:45.053] Build status: STARTED
[19:18:45.053] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:44:0) after 5m45s
[19:24:30.712] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:44:0)
[19:24:30.746] Build status: STARTED
[19:24:30.746] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:45:0) after 4m31s
[19:29:01.933] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:45:0)
[19:29:01.957] Build status: STARTED
[19:29:01.957] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:46:0) after 1m28s
[19:30:30.287] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:46:0)
[19:30:30.306] Build status: STARTED
[19:30:30.306] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:47:0) after 8m22s
[19:38:52.424] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:47:0)
[19:38:52.449] Build status: STARTED
[19:38:52.449] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:48:0) after 3m54s
[19:42:46.990] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:48:0)
[19:42:47.026] Build status: STARTED
[19:42:47.026] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8954330524822816880:49:0) after 8m22s
[19:50:20.413] Received PubSub notification, asking Buildbucket for the build status
[19:50:20.438] Build:
{
"id": "8788900462272725233",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 11414,
"createdBy": "project:infra",
"createTime": "2023-02-17T15:39:41.887988057Z",
"startTime": "2023-02-17T15:40:12.101222Z",
"endTime": "2023-02-17T19:50:20.112091708Z",
"updateTime": "2023-02-17T19:50:20.112091708Z",
"status": "SUCCESS",
"input": {
}
}
[19:50:20.438] Invocation finished in 4h10m40.366748313s with status SUCCEEDED