[12:14:32.677] New invocation is queued and will start shortly
[12:14:32.677] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[12:14:33.770] Starting the invocation (attempt 1)
[12:14:33.814] Ignoring gitiles_ref tag without the buildset tag
[12:14:33.814] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:14:33.814] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:14:33.814] Buildbucket request:
{
"requestId": "8965486856938867824",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8965486856938867824",
"job": "infra/codesearch-gen-chromium-win",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "7170e7a54e771dc6e768cf8e13f2b937234970b1",
"codesearch_mirror_revision_timestamp": 1666008007,
"root_solution_revision": "ac942f7d59c04af3c2cf0f7b6bd411f2f34e69b5",
"root_solution_revision_timestamp": 1666007719
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:16035",
"user_agent:recipe"
]
},
"id": "282e8f46-e522-4f70-be2b-def727e014bf",
"title": "codesearch-gen-chromium-initiator/16035"
}
]
},
"codesearch_mirror_revision": "7170e7a54e771dc6e768cf8e13f2b937234970b1",
"codesearch_mirror_revision_timestamp": 1666008007,
"root_solution_revision": "ac942f7d59c04af3c2cf0f7b6bd411f2f34e69b5",
"root_solution_revision_timestamp": 1666007719
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8965486856938867824"
},
{
"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": "16035"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:14:34.216] Scheduled build:
{
"id": "8800056795002125953",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 10727,
"createdBy": "project:infra",
"createTime": "2022-10-17T12:14:33.898742460Z",
"updateTime": "2022-10-17T12:14:33.898742460Z",
"status": "SCHEDULED",
"input": {
}
}
[12:14:34.216] Task URL: https://cr-buildbucket.appspot.com/build/8800056795002125953
[12:14:34.216] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:2:0) after 9m26s
[12:15:28.546] Received PubSub notification, asking Buildbucket for the build status
[12:15:28.585] Build status: STARTED
[12:24:00.336] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:2:0)
[12:24:00.363] Build status: STARTED
[12:24:00.364] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:4:0) after 3m30s
[12:27:30.552] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:4:0)
[12:27:30.585] Build status: STARTED
[12:27:30.585] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:5:0) after 8m19s
[12:35:49.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:5:0)
[12:35:49.628] Build status: STARTED
[12:35:49.628] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:6:0) after 4m5s
[12:39:54.654] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:6:0)
[12:39:54.678] Build status: STARTED
[12:39:54.679] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:7:0) after 6m11s
[12:46:05.703] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:7:0)
[12:46:05.728] Build status: STARTED
[12:46:05.728] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:8:0) after 6m15s
[12:52:20.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:8:0)
[12:52:20.868] Build status: STARTED
[12:52:20.868] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:9:0) after 5m32s
[12:57:53.094] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:9:0)
[12:57:53.145] Build status: STARTED
[12:57:53.145] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:10:0) after 8m12s
[13:06:05.229] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:10:0)
[13:06:05.252] Build status: STARTED
[13:06:05.252] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:11:0) after 5m33s
[13:11:38.452] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:11:0)
[13:11:38.488] Build status: STARTED
[13:11:38.488] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:12:0) after 7m27s
[13:19:05.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:12:0)
[13:19:05.756] Build status: STARTED
[13:19:05.756] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:13:0) after 8m15s
[13:27:20.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:13:0)
[13:27:20.800] Build status: STARTED
[13:27:20.800] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:14:0) after 6m9s
[13:33:30.018] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:14:0)
[13:33:30.056] Build status: STARTED
[13:33:30.056] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:15:0) after 8m39s
[13:42:09.075] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:15:0)
[13:42:09.098] Build status: STARTED
[13:42:09.098] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:16:0) after 2m47s
[13:44:56.124] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:16:0)
[13:44:56.155] Build status: STARTED
[13:44:56.155] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:17:0) after 6m50s
[13:51:46.396] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:17:0)
[13:51:46.421] Build status: STARTED
[13:51:46.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:18:0) after 5m57s
[13:57:43.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:18:0)
[13:57:43.621] Build status: STARTED
[13:57:43.621] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:19:0) after 8m27s
[14:06:10.666] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:19:0)
[14:06:10.715] Build status: STARTED
[14:06:10.715] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:20:0) after 8m52s
[14:15:02.703] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:20:0)
[14:15:02.726] Build status: STARTED
[14:15:02.726] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:21:0) after 8m22s
[14:23:24.815] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:21:0)
[14:23:24.869] Build status: STARTED
[14:23:24.869] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:22:0) after 7m1s
[14:30:26.139] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:22:0)
[14:30:26.189] Build status: STARTED
[14:30:26.189] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:23:0) after 6m25s
[14:36:51.222] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:23:0)
[14:36:51.247] Build status: STARTED
[14:36:51.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:24:0) after 2m13s
[14:39:04.459] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:24:0)
[14:39:04.483] Build status: STARTED
[14:39:04.483] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:25:0) after 1m26s
[14:40:30.539] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:25:0)
[14:40:30.582] Build status: STARTED
[14:40:30.582] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:26:0) after 2m57s
[14:43:28.064] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:26:0)
[14:43:28.111] Build status: STARTED
[14:43:28.111] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:27:0) after 6m40s
[14:50:08.327] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:27:0)
[14:50:08.358] Build status: STARTED
[14:50:08.358] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:28:0) after 4m16s
[14:54:24.401] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:28:0)
[14:54:24.431] Build status: STARTED
[14:54:24.431] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:29:0) after 6m40s
[15:01:04.681] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:29:0)
[15:01:04.710] Build status: STARTED
[15:01:04.710] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:30:0) after 4m55s
[15:05:59.995] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:30:0)
[15:06:00.040] Build status: STARTED
[15:06:00.040] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:31:0) after 4m5s
[15:10:05.438] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:31:0)
[15:10:05.494] Build status: STARTED
[15:10:05.494] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:32:0) after 5m1s
[15:15:06.595] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:32:0)
[15:15:06.620] Build status: STARTED
[15:15:06.620] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:33:0) after 5m19s
[15:20:25.668] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:33:0)
[15:20:25.702] Build status: STARTED
[15:20:25.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:34:0) after 2m11s
[15:22:36.824] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:34:0)
[15:22:36.853] Build status: STARTED
[15:22:36.853] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:35:0) after 3m52s
[15:26:29.457] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:35:0)
[15:26:29.479] Build status: STARTED
[15:26:29.479] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:36:0) after 6m38s
[15:33:07.693] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:36:0)
[15:33:07.720] Build status: STARTED
[15:33:07.720] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:37:0) after 6m11s
[15:39:18.742] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:37:0)
[15:39:18.773] Build status: STARTED
[15:39:18.773] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:38:0) after 4m9s
[15:43:27.992] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:38:0)
[15:43:28.015] Build status: STARTED
[15:43:28.015] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:39:0) after 1m44s
[15:45:12.284] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:39:0)
[15:45:12.332] Build status: STARTED
[15:45:12.332] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:40:0) after 5m7s
[15:50:19.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:40:0)
[15:50:19.668] Build status: STARTED
[15:50:19.668] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:41:0) after 9m16s
[15:59:35.842] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:41:0)
[15:59:35.868] Build status: STARTED
[15:59:35.868] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:42:0) after 9m46s
[16:09:21.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:42:0)
[16:09:21.896] Build status: STARTED
[16:09:21.896] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8965486856938867824:43:0) after 7m44s
[16:10:07.871] Received PubSub notification, asking Buildbucket for the build status
[16:10:07.896] Build:
{
"id": "8800056795002125953",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 10727,
"createdBy": "project:infra",
"createTime": "2022-10-17T12:14:33.898742460Z",
"startTime": "2022-10-17T12:15:27.679796Z",
"endTime": "2022-10-17T16:10:07.006394436Z",
"updateTime": "2022-10-17T16:10:07.006394436Z",
"status": "SUCCESS",
"input": {
}
}
[16:10:07.896] Invocation finished in 3h55m35.229775564s with status SUCCEEDED