[03:29:41.305] New invocation is queued and will start shortly
[03:29:41.305] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[03:29:42.393] Starting the invocation (attempt 1)
[03:29:42.416] Ignoring gitiles_ref tag without the buildset tag
[03:29:42.416] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:29:42.417] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:29:42.417] Buildbucket request:
{
"requestId": "8940062130477982832",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8940062130477982832",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "7d2d8ccab2b68fbbfc5e1611d45bd4ecf87090b8",
"codesearch_mirror_revision_timestamp": 1690243243,
"root_solution_revision": "c9d1029a4283402b0c9be830dbf2b57eaf8b9a19",
"root_solution_revision_timestamp": 1690242774
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17718",
"user_agent:recipe"
]
},
"id": "f3169b7e-5837-49cd-8382-7ecc9a739e12",
"title": "codesearch-gen-chromium-initiator/17718"
}
]
},
"codesearch_mirror_revision": "7d2d8ccab2b68fbbfc5e1611d45bd4ecf87090b8",
"codesearch_mirror_revision_timestamp": 1690243243,
"root_solution_revision": "c9d1029a4283402b0c9be830dbf2b57eaf8b9a19",
"root_solution_revision_timestamp": 1690242774
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8940062130477982832"
},
{
"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": "17718"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:29:42.927] Scheduled build:
{
"id": "8774632068593480097",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 12213,
"createdBy": "project:infra",
"createTime": "2023-07-25T03:29:42.475353089Z",
"updateTime": "2023-07-25T03:29:42.475353089Z",
"status": "SCHEDULED",
"input": {
}
}
[03:29:42.927] Task URL: https://cr-buildbucket.appspot.com/build/8774632068593480097
[03:29:42.927] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:2:0) after 8m47s
[03:29:43.803] Received PubSub notification, asking Buildbucket for the build status
[03:29:43.828] Build status: SCHEDULED
[03:30:38.221] Received PubSub notification, asking Buildbucket for the build status
[03:30:38.262] Build status: STARTED
[03:38:30.128] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:2:0)
[03:38:30.156] Build status: STARTED
[03:38:30.156] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:5:0) after 3m2s
[03:41:32.293] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:5:0)
[03:41:32.337] Build status: STARTED
[03:41:32.337] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:6:0) after 9m34s
[03:51:06.452] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:6:0)
[03:51:06.487] Build status: STARTED
[03:51:06.487] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:7:0) after 8m20s
[03:59:26.505] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:7:0)
[03:59:26.541] Build status: STARTED
[03:59:26.541] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:8:0) after 8m20s
[04:07:46.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:8:0)
[04:07:46.909] Build status: STARTED
[04:07:46.909] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:9:0) after 9m37s
[04:17:23.925] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:9:0)
[04:17:23.944] Build status: STARTED
[04:17:23.944] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:10:0) after 8m34s
[04:25:58.263] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:10:0)
[04:25:58.292] Build status: STARTED
[04:25:58.292] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:11:0) after 3m5s
[04:29:03.305] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:11:0)
[04:29:03.331] Build status: STARTED
[04:29:03.331] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:12:0) after 6m53s
[04:35:56.437] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:12:0)
[04:35:56.455] Build status: STARTED
[04:35:56.455] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:13:0) after 4m22s
[04:40:18.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:13:0)
[04:40:18.489] Build status: STARTED
[04:40:18.489] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:14:0) after 5m49s
[04:46:07.503] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:14:0)
[04:46:07.545] Build status: STARTED
[04:46:07.546] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:15:0) after 7m39s
[04:53:46.619] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:15:0)
[04:53:46.645] Build status: STARTED
[04:53:46.645] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:16:0) after 7m23s
[05:01:09.776] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:16:0)
[05:01:09.870] Build status: STARTED
[05:01:09.870] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:17:0) after 7m21s
[05:08:30.886] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:17:0)
[05:08:30.918] Build status: STARTED
[05:08:30.918] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:18:0) after 4m20s
[05:12:50.934] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:18:0)
[05:12:50.952] Build status: STARTED
[05:12:50.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:19:0) after 8m5s
[05:20:56.085] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:19:0)
[05:20:56.123] Build status: STARTED
[05:20:56.123] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:20:0) after 8m0s
[05:28:56.137] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:20:0)
[05:28:56.170] Build status: STARTED
[05:28:56.170] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:21:0) after 5m34s
[05:34:30.512] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:21:0)
[05:34:30.532] Build status: STARTED
[05:34:30.532] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:22:0) after 9m3s
[05:43:33.550] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:22:0)
[05:43:33.572] Build status: STARTED
[05:43:33.572] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:23:0) after 3m56s
[05:47:29.544] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:23:0)
[05:47:29.704] Build status: STARTED
[05:47:29.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:24:0) after 7m46s
[05:55:15.838] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:24:0)
[05:55:15.860] Build status: STARTED
[05:55:15.860] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:25:0) after 8m0s
[06:03:16.005] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:25:0)
[06:03:16.035] Build status: STARTED
[06:03:16.035] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:26:0) after 4m13s
[06:07:29.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:26:0)
[06:07:29.186] Build status: STARTED
[06:07:29.186] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:27:0) after 6m41s
[06:14:10.210] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:27:0)
[06:14:10.242] Build status: STARTED
[06:14:10.242] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:28:0) after 4m56s
[06:19:06.434] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:28:0)
[06:19:06.463] Build status: STARTED
[06:19:06.463] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:29:0) after 5m7s
[06:24:13.584] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:29:0)
[06:24:13.642] Build status: STARTED
[06:24:13.643] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:30:0) after 7m14s
[06:31:27.706] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:30:0)
[06:31:27.723] Build status: STARTED
[06:31:27.723] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:31:0) after 1m46s
[06:33:13.711] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:31:0)
[06:33:13.729] Build status: STARTED
[06:33:13.729] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:32:0) after 8m50s
[06:42:03.878] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:32:0)
[06:42:03.898] Build status: STARTED
[06:42:03.899] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:33:0) after 5m16s
[06:47:19.915] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:33:0)
[06:47:19.931] Build status: STARTED
[06:47:19.931] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:34:0) after 9m49s
[06:57:08.965] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:34:0)
[06:57:09.157] Build status: STARTED
[06:57:09.157] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:35:0) after 8m43s
[07:05:52.300] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:35:0)
[07:05:52.335] Build status: STARTED
[07:05:52.336] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:36:0) after 1m7s
[07:06:59.403] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:36:0)
[07:06:59.438] Build status: STARTED
[07:06:59.438] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:37:0) after 2m5s
[07:09:04.498] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:37:0)
[07:09:04.522] Build status: STARTED
[07:09:04.522] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:38:0) after 6m52s
[07:15:56.562] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:38:0)
[07:15:56.600] Build status: STARTED
[07:15:56.600] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:39:0) after 6m38s
[07:22:34.810] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:39:0)
[07:22:34.854] Build status: STARTED
[07:22:34.854] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:40:0) after 6m35s
[07:29:09.881] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:40:0)
[07:29:09.909] Build status: STARTED
[07:29:09.909] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:41:0) after 2m40s
[07:31:49.969] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:41:0)
[07:31:49.993] Build status: STARTED
[07:31:49.993] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:42:0) after 1m59s
[07:33:49.201] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:42:0)
[07:33:49.245] Build status: STARTED
[07:33:49.245] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:43:0) after 2m19s
[07:36:08.594] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:43:0)
[07:36:08.632] Build status: STARTED
[07:36:08.632] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:44:0) after 7m3s
[07:43:11.810] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:44:0)
[07:43:11.842] Build status: STARTED
[07:43:11.842] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:45:0) after 1m37s
[07:44:48.935] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:45:0)
[07:44:49.150] Build status: STARTED
[07:44:49.150] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:46:0) after 8m19s
[07:53:08.185] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:46:0)
[07:53:08.216] Build status: STARTED
[07:53:08.216] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:47:0) after 8m51s
[08:01:59.551] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:47:0)
[08:01:59.602] Build status: STARTED
[08:01:59.602] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:48:0) after 1m32s
[08:03:31.675] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:48:0)
[08:03:31.695] Build status: STARTED
[08:03:31.695] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:49:0) after 1m9s
[08:04:40.992] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:49:0)
[08:04:41.015] Build status: STARTED
[08:04:41.015] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:50:0) after 8m2s
[08:12:43.041] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:50:0)
[08:12:43.072] Build status: STARTED
[08:12:43.072] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:51:0) after 6m54s
[08:19:37.264] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:51:0)
[08:19:37.284] Build status: STARTED
[08:19:37.284] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:52:0) after 4m40s
[08:24:17.402] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:52:0)
[08:24:17.424] Build status: STARTED
[08:24:17.424] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:53:0) after 1m21s
[08:25:38.531] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:53:0)
[08:25:38.557] Build status: STARTED
[08:25:38.557] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:54:0) after 9m35s
[08:35:13.813] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:54:0)
[08:35:13.845] Build status: STARTED
[08:35:13.845] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:55:0) after 2m52s
[08:38:06.093] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:55:0)
[08:38:06.126] Build status: STARTED
[08:38:06.126] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:56:0) after 9m57s
[08:48:03.289] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:56:0)
[08:48:03.311] Build status: STARTED
[08:48:03.311] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:57:0) after 8m59s
[08:57:02.396] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:57:0)
[08:57:02.416] Build status: STARTED
[08:57:02.416] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:58:0) after 5m13s
[09:02:15.533] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:58:0)
[09:02:15.553] Build status: STARTED
[09:02:15.553] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:59:0) after 1m41s
[09:03:56.571] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:59:0)
[09:03:56.587] Build status: STARTED
[09:03:56.587] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8940062130477982832:60:0) after 8m42s
[09:06:08.501] Received PubSub notification, asking Buildbucket for the build status
[09:06:08.520] Build:
{
"id": "8774632068593480097",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 12213,
"createdBy": "project:infra",
"createTime": "2023-07-25T03:29:42.475353089Z",
"startTime": "2023-07-25T03:30:37.715189Z",
"endTime": "2023-07-25T09:06:08.293832982Z",
"updateTime": "2023-07-25T09:06:08.293832982Z",
"status": "SUCCESS",
"input": {
}
}
[09:06:08.520] Invocation finished in 5h36m27.224592004s with status SUCCEEDED