[08:03:29.029] New invocation is queued and will start shortly
[08:03:29.029] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[08:03:30.733] Starting the invocation (attempt 1)
[08:03:30.771] Ignoring gitiles_ref tag without the buildset tag
[08:03:30.771] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:30.771] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:30.771] Buildbucket request:
{
"requestId": "8967223994693093472",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8967223994693093472",
"job": "infra/codesearch-gen-chromium-linux",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "ce6f8713ea3d6b8ede23911248fcfc845690ae3c",
"codesearch_mirror_revision_timestamp": 1664351863,
"root_solution_revision": "e17ad8f8d70a6b1fd2d3461ad1d521a74e1fc971",
"root_solution_revision_timestamp": 1664351457
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15920",
"user_agent:recipe"
]
},
"id": "a7490efa-ec12-4f4e-aeed-dab89d0aab45",
"title": "codesearch-gen-chromium-initiator/15920"
}
]
},
"codesearch_mirror_revision": "ce6f8713ea3d6b8ede23911248fcfc845690ae3c",
"codesearch_mirror_revision_timestamp": 1664351863,
"root_solution_revision": "e17ad8f8d70a6b1fd2d3461ad1d521a74e1fc971",
"root_solution_revision_timestamp": 1664351457
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967223994693093472"
},
{
"key": "scheduler_job_id",
"value": "infra/codesearch-gen-chromium-linux"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "codesearch-gen-chromium-initiator"
},
{
"key": "parent_buildnumber",
"value": "15920"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:03:31.182] Scheduled build:
{
"id": "8801793932115182081",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-linux"
},
"number": 13573,
"createdBy": "project:infra",
"createTime": "2022-09-28T08:03:30.849496800Z",
"updateTime": "2022-09-28T08:03:30.849496800Z",
"status": "SCHEDULED",
"input": {
},
"canary": true
}
[08:03:31.182] Task URL: https://cr-buildbucket.appspot.com/build/8801793932115182081
[08:03:31.182] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:2:0) after 9m9s
[08:04:04.456] Received PubSub notification, asking Buildbucket for the build status
[08:04:04.493] Build status: STARTED
[08:12:40.285] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:2:0)
[08:12:40.326] Build status: STARTED
[08:12:40.326] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:4:0) after 3m36s
[08:16:16.360] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:4:0)
[08:16:16.400] Build status: STARTED
[08:16:16.400] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:5:0) after 4m7s
[08:20:23.423] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:5:0)
[08:20:23.470] Build status: STARTED
[08:20:23.470] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:6:0) after 5m43s
[08:26:06.514] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:6:0)
[08:26:06.537] Build status: STARTED
[08:26:06.537] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:7:0) after 6m6s
[08:32:12.559] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:7:0)
[08:32:12.589] Build status: STARTED
[08:32:12.589] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:8:0) after 4m42s
[08:36:54.749] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:8:0)
[08:36:54.781] Build status: STARTED
[08:36:54.781] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:9:0) after 8m10s
[08:45:04.809] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:9:0)
[08:45:04.904] Build status: STARTED
[08:45:04.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:10:0) after 2m43s
[08:47:48.022] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:10:0)
[08:47:48.058] Build status: STARTED
[08:47:48.058] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:11:0) after 4m55s
[08:52:43.222] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:11:0)
[08:52:43.241] Build status: STARTED
[08:52:43.241] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:12:0) after 2m46s
[08:55:29.312] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:12:0)
[08:55:29.341] Build status: STARTED
[08:55:29.341] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:13:0) after 2m9s
[08:57:38.463] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:13:0)
[08:57:38.500] Build status: STARTED
[08:57:38.500] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:14:0) after 1m18s
[08:58:56.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:14:0)
[08:58:56.706] Build status: STARTED
[08:58:56.706] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:15:0) after 5m6s
[09:04:02.845] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:15:0)
[09:04:02.867] Build status: STARTED
[09:04:02.867] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:16:0) after 2m19s
[09:06:21.967] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:16:0)
[09:06:21.997] Build status: STARTED
[09:06:21.997] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:17:0) after 1m26s
[09:07:48.030] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:17:0)
[09:07:48.076] Build status: STARTED
[09:07:48.076] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:18:0) after 1m41s
[09:09:29.111] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:18:0)
[09:09:29.157] Build status: STARTED
[09:09:29.157] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:19:0) after 8m20s
[09:17:49.521] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:19:0)
[09:17:49.545] Build status: STARTED
[09:17:49.545] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:20:0) after 4m35s
[09:22:24.665] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:20:0)
[09:22:24.690] Build status: STARTED
[09:22:24.690] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:21:0) after 3m23s
[09:25:48.088] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:21:0)
[09:25:48.112] Build status: STARTED
[09:25:48.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:22:0) after 8m41s
[09:34:29.220] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:22:0)
[09:34:29.245] Build status: STARTED
[09:34:29.245] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:23:0) after 3m10s
[09:37:39.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:23:0)
[09:37:39.778] Build status: STARTED
[09:37:39.778] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:24:0) after 8m30s
[09:46:09.903] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:24:0)
[09:46:09.935] Build status: STARTED
[09:46:09.935] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:25:0) after 3m42s
[09:49:52.325] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:25:0)
[09:49:52.351] Build status: STARTED
[09:49:52.351] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:26:0) after 3m12s
[09:53:04.370] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:26:0)
[09:53:04.401] Build status: STARTED
[09:53:04.401] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:27:0) after 2m16s
[09:55:20.429] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:27:0)
[09:55:20.472] Build status: STARTED
[09:55:20.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:28:0) after 2m32s
[09:57:52.494] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:28:0)
[09:57:52.519] Build status: STARTED
[09:57:52.519] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:29:0) after 1m23s
[09:59:15.570] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:29:0)
[09:59:15.592] Build status: STARTED
[09:59:15.592] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:30:0) after 8m50s
[10:08:05.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:30:0)
[10:08:05.804] Build status: STARTED
[10:08:05.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:31:0) after 6m59s
[10:15:04.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:31:0)
[10:15:04.850] Build status: STARTED
[10:15:04.850] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:32:0) after 4m10s
[10:19:14.975] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:32:0)
[10:19:15.005] Build status: STARTED
[10:19:15.005] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:8967223994693093472:33:0) after 9m58s
[10:20:23.077] Received PubSub notification, asking Buildbucket for the build status
[10:20:23.118] Build:
{
"id": "8801793932115182081",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-linux"
},
"number": 13573,
"createdBy": "project:infra",
"createTime": "2022-09-28T08:03:30.849496800Z",
"startTime": "2022-09-28T08:04:03.760669Z",
"endTime": "2022-09-28T10:20:22.683301341Z",
"updateTime": "2022-09-28T10:20:22.683301341Z",
"status": "SUCCESS",
"input": {
},
"canary": true
}
[10:20:23.118] Invocation finished in 2h16m54.111701053s with status SUCCEEDED