[12:02:27.144] New invocation is queued and will start shortly
[12:02:27.144] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[12:02:28.274] Starting the invocation (attempt 1)
[12:02:28.307] Ignoring gitiles_ref tag without the buildset tag
[12:02:28.307] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:02:28.307] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:02:28.307] Buildbucket request:
{
"requestId": "8993663274270183328",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "14a4a8b66cd370bfad57983df2875afde8f91c5d",
"codesearch_mirror_revision_timestamp": 1639137614,
"root_solution_revision": "fb6232ffb1fec14d64ec8815f7dfc2cea0887588",
"root_solution_revision_timestamp": 1639137509
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:14169",
"user_agent:recipe"
]
},
"id": "0bcdbb6e-4f13-4b56-8a89-cdc9c3edefe9",
"title": "codesearch-gen-chromium-initiator/14169"
}
]
},
"codesearch_mirror_revision": "14a4a8b66cd370bfad57983df2875afde8f91c5d",
"codesearch_mirror_revision_timestamp": 1639137614,
"root_solution_revision": "fb6232ffb1fec14d64ec8815f7dfc2cea0887588",
"root_solution_revision_timestamp": 1639137509
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8993663274270183328"
},
{
"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": "14169"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:02:28.956] Scheduled build:
{
"id": "8828233212336972945",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 8887,
"createdBy": "project:infra",
"createTime": "2021-12-10T12:02:28.357614199Z",
"updateTime": "2021-12-10T12:02:28.357614199Z",
"status": "SCHEDULED",
"input": {
}
}
[12:02:28.956] Task URL: https://cr-buildbucket.appspot.com/build/8828233212336972945
[12:02:28.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:2:0) after 1m6s
[12:03:16.908] Received PubSub notification, asking Buildbucket for the build status
[12:03:16.939] Build status: STARTED
[12:03:35.053] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:2:0)
[12:03:35.084] Build status: STARTED
[12:03:35.084] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:4:0) after 7m7s
[12:10:42.148] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:4:0)
[12:10:42.188] Build status: STARTED
[12:10:42.188] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:5:0) after 5m36s
[12:16:18.309] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:5:0)
[12:16:18.348] Build status: STARTED
[12:16:18.348] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:6:0) after 1m19s
[12:17:37.363] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:6:0)
[12:17:37.394] Build status: STARTED
[12:17:37.394] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:7:0) after 9m35s
[12:27:12.620] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:7:0)
[12:27:12.691] Build status: STARTED
[12:27:12.691] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:8:0) after 8m21s
[12:35:33.789] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:8:0)
[12:35:33.821] Build status: STARTED
[12:35:33.821] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:9:0) after 6m51s
[12:42:24.844] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:9:0)
[12:42:24.876] Build status: STARTED
[12:42:24.876] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:10:0) after 7m43s
[12:50:07.910] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:10:0)
[12:50:07.940] Build status: STARTED
[12:50:07.940] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:11:0) after 8m27s
[12:58:34.988] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:11:0)
[12:58:35.019] Build status: STARTED
[12:58:35.019] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:12:0) after 7m17s
[13:05:52.035] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:12:0)
[13:05:52.066] Build status: STARTED
[13:05:52.066] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:13:0) after 1m16s
[13:07:08.085] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:13:0)
[13:07:08.127] Build status: STARTED
[13:07:08.127] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:14:0) after 1m14s
[13:08:22.121] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:14:0)
[13:08:22.142] Build status: STARTED
[13:08:22.142] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:15:0) after 5m35s
[13:13:57.194] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:15:0)
[13:13:57.226] Build status: STARTED
[13:13:57.226] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:16:0) after 8m33s
[13:22:30.279] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:16:0)
[13:22:30.310] Build status: STARTED
[13:22:30.310] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:17:0) after 2m2s
[13:24:32.328] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:17:0)
[13:24:32.362] Build status: STARTED
[13:24:32.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:18:0) after 4m52s
[13:29:24.582] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:18:0)
[13:29:24.612] Build status: STARTED
[13:29:24.612] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:19:0) after 1m57s
[13:31:21.634] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:19:0)
[13:31:21.664] Build status: STARTED
[13:31:21.664] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:20:0) after 7m8s
[13:38:29.784] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:20:0)
[13:38:29.814] Build status: STARTED
[13:38:29.814] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:21:0) after 7m21s
[13:45:51.073] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:21:0)
[13:45:51.095] Build status: STARTED
[13:45:51.095] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:22:0) after 1m28s
[13:47:19.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:22:0)
[13:47:19.805] Build status: STARTED
[13:47:19.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:23:0) after 3m48s
[13:51:07.862] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:23:0)
[13:51:07.917] Build status: STARTED
[13:51:07.917] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:24:0) after 2m27s
[13:53:34.937] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:24:0)
[13:53:34.968] Build status: STARTED
[13:53:34.968] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:25:0) after 2m34s
[13:56:09.021] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:25:0)
[13:56:09.053] Build status: STARTED
[13:56:09.053] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:26:0) after 6m45s
[14:02:54.123] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:26:0)
[14:02:54.353] Build status: STARTED
[14:02:54.353] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:27:0) after 3m10s
[14:06:04.406] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:27:0)
[14:06:04.489] Build status: STARTED
[14:06:04.489] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:28:0) after 9m37s
[14:15:41.673] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:28:0)
[14:15:41.703] Build status: STARTED
[14:15:41.703] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:29:0) after 9m54s
[14:25:35.721] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:29:0)
[14:25:35.752] Build status: STARTED
[14:25:35.752] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:30:0) after 6m58s
[14:32:33.867] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:30:0)
[14:32:33.918] Build status: STARTED
[14:32:33.918] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:31:0) after 5m22s
[14:37:55.960] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:31:0)
[14:37:55.990] Build status: STARTED
[14:37:55.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:32:0) after 2m48s
[14:40:44.061] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:32:0)
[14:40:44.106] Build status: STARTED
[14:40:44.106] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:33:0) after 4m13s
[14:44:57.128] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:33:0)
[14:44:57.167] Build status: STARTED
[14:44:57.167] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:34:0) after 4m48s
[14:49:45.219] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:34:0)
[14:49:45.254] Build status: STARTED
[14:49:45.254] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:35:0) after 3m49s
[14:53:34.284] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:35:0)
[14:53:34.333] Build status: STARTED
[14:53:34.333] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:36:0) after 2m16s
[14:55:50.361] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:36:0)
[14:55:50.411] Build status: STARTED
[14:55:50.411] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:37:0) after 1m40s
[14:57:30.429] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:37:0)
[14:57:30.467] Build status: STARTED
[14:57:30.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:38:0) after 1m36s
[14:59:06.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:38:0)
[14:59:06.518] Build status: STARTED
[14:59:06.518] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:39:0) after 5m40s
[15:04:46.607] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:39:0)
[15:04:46.659] Build status: STARTED
[15:04:46.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:40:0) after 1m2s
[15:05:48.755] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:40:0)
[15:05:48.802] Build status: STARTED
[15:05:48.802] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:41:0) after 6m22s
[15:12:10.825] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:41:0)
[15:12:10.857] Build status: STARTED
[15:12:10.857] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:8993663274270183328:42:0) after 4m19s
[15:13:46.557] Received PubSub notification, asking Buildbucket for the build status
[15:13:46.636] Build:
{
"id": "8828233212336972945",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-win"
},
"number": 8887,
"createdBy": "project:infra",
"createTime": "2021-12-10T12:02:28.357614199Z",
"startTime": "2021-12-10T12:03:15.515410Z",
"endTime": "2021-12-10T15:13:46.240807660Z",
"updateTime": "2021-12-10T15:13:46.240807660Z",
"status": "SUCCESS",
"input": {
}
}
[15:13:46.636] Invocation finished in 3h11m19.506421926s with status SUCCEEDED