[01:46:24.081] New invocation is queued and will start shortly
[01:46:24.082] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[01:46:25.243] Starting the invocation (attempt 1)
[01:46:25.284] Ignoring gitiles_ref tag without the buildset tag
[01:46:25.285] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:46:25.285] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:46:25.285] Buildbucket request:
{
"requestId": "8975401445637689840",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8975401445637689840",
"job": "infra/codesearch-gen-chromium-mac",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "231c667affa80fd5ac2b83eaef5d3af1f0dfee15",
"codesearch_mirror_revision_timestamp": 1656547201,
"root_solution_revision": "ff0920b3d2ae8160c7050d95c7be9177f0722e86",
"root_solution_revision_timestamp": 1656547114
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:15378",
"user_agent:recipe"
]
},
"id": "11a89f23-0be0-44d4-9e18-830fc454ce41",
"title": "codesearch-gen-chromium-initiator/15378"
}
]
},
"codesearch_mirror_revision": "231c667affa80fd5ac2b83eaef5d3af1f0dfee15",
"codesearch_mirror_revision_timestamp": 1656547201,
"root_solution_revision": "ff0920b3d2ae8160c7050d95c7be9177f0722e86",
"root_solution_revision_timestamp": 1656547114
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8975401445637689840"
},
{
"key": "scheduler_job_id",
"value": "infra/codesearch-gen-chromium-mac"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "codesearch-gen-chromium-initiator"
},
{
"key": "parent_buildnumber",
"value": "15378"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:46:25.767] Scheduled build:
{
"id": "8809971383641769233",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 334,
"createdBy": "project:infra",
"createTime": "2022-06-30T01:46:25.354931767Z",
"updateTime": "2022-06-30T01:46:25.354931767Z",
"status": "SCHEDULED",
"input": {
}
}
[01:46:25.767] Task URL: https://cr-buildbucket.appspot.com/build/8809971383641769233
[01:46:25.767] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:2:0) after 9m13s
[01:48:19.574] Received PubSub notification, asking Buildbucket for the build status
[01:48:19.609] Build status: STARTED
[01:55:38.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:2:0)
[01:55:38.816] Build status: STARTED
[01:55:38.816] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:4:0) after 5m6s
[02:00:45.175] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:4:0)
[02:00:45.213] Build status: STARTED
[02:00:45.213] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:5:0) after 4m34s
[02:05:19.399] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:5:0)
[02:05:19.444] Build status: STARTED
[02:05:19.444] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:6:0) after 1m4s
[02:06:23.473] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:6:0)
[02:06:23.514] Build status: STARTED
[02:06:23.514] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:7:0) after 3m58s
[02:10:21.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:7:0)
[02:10:21.650] Build status: STARTED
[02:10:21.650] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:8:0) after 5m57s
[02:16:18.767] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:8:0)
[02:16:18.797] Build status: STARTED
[02:16:18.797] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:9:0) after 6m21s
[02:22:39.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:9:0)
[02:22:39.955] Build status: STARTED
[02:22:39.955] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:10:0) after 1m22s
[02:24:02.077] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:10:0)
[02:24:02.318] Build status: STARTED
[02:24:02.318] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:11:0) after 9m46s
[02:33:48.435] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:11:0)
[02:33:48.467] Build status: STARTED
[02:33:48.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:12:0) after 2m47s
[02:36:35.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:12:0)
[02:36:35.518] Build status: STARTED
[02:36:35.518] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:13:0) after 5m54s
[02:42:30.060] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:13:0)
[02:42:30.141] Build status: STARTED
[02:42:30.141] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:14:0) after 3m29s
[02:45:59.253] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:14:0)
[02:45:59.338] Build status: STARTED
[02:45:59.338] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:15:0) after 3m15s
[02:49:14.370] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:15:0)
[02:49:14.401] Build status: STARTED
[02:49:14.401] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:16:0) after 6m10s
[02:55:24.660] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:16:0)
[02:55:24.751] Build status: STARTED
[02:55:24.751] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:17:0) after 8m44s
[03:04:08.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:17:0)
[03:04:08.807] Build status: STARTED
[03:04:08.807] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:18:0) after 9m44s
[03:13:52.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:18:0)
[03:13:52.874] Build status: STARTED
[03:13:52.874] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:19:0) after 2m5s
[03:15:57.892] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:19:0)
[03:15:57.931] Build status: STARTED
[03:15:57.931] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:20:0) after 3m38s
[03:19:35.954] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:20:0)
[03:19:36.010] Build status: STARTED
[03:19:36.011] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:21:0) after 2m10s
[03:21:46.241] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:21:0)
[03:21:46.275] Build status: STARTED
[03:21:46.275] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:22:0) after 7m28s
[03:29:14.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:22:0)
[03:29:14.345] Build status: STARTED
[03:29:14.345] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:23:0) after 5m26s
[03:34:40.380] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:23:0)
[03:34:40.412] Build status: STARTED
[03:34:40.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:24:0) after 7m30s
[03:42:10.511] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:24:0)
[03:42:10.551] Build status: STARTED
[03:42:10.551] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:25:0) after 5m42s
[03:47:52.604] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:25:0)
[03:47:52.645] Build status: STARTED
[03:47:52.645] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:26:0) after 2m53s
[03:50:45.814] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:26:0)
[03:50:45.881] Build status: STARTED
[03:50:45.881] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:27:0) after 1m33s
[03:52:18.907] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:27:0)
[03:52:18.982] Build status: STARTED
[03:52:18.982] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:28:0) after 7m32s
[03:59:51.006] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:28:0)
[03:59:51.046] Build status: STARTED
[03:59:51.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:29:0) after 7m54s
[04:07:45.120] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:29:0)
[04:07:45.180] Build status: STARTED
[04:07:45.180] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:30:0) after 7m3s
[04:14:48.406] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:30:0)
[04:14:48.442] Build status: STARTED
[04:14:48.442] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:31:0) after 9m16s
[04:24:04.567] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:31:0)
[04:24:04.625] Build status: STARTED
[04:24:04.625] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:32:0) after 1m55s
[04:25:59.690] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:32:0)
[04:25:59.728] Build status: STARTED
[04:25:59.728] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:33:0) after 4m11s
[04:30:10.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:33:0)
[04:30:10.873] Build status: STARTED
[04:30:10.873] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:34:0) after 2m46s
[04:32:56.915] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:34:0)
[04:32:56.949] Build status: STARTED
[04:32:56.949] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:35:0) after 4m52s
[04:37:48.985] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:35:0)
[04:37:49.075] Build status: STARTED
[04:37:49.075] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:36:0) after 7m28s
[04:45:17.162] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:36:0)
[04:45:17.193] Build status: STARTED
[04:45:17.193] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:37:0) after 9m29s
[04:54:46.210] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:37:0)
[04:54:46.247] Build status: STARTED
[04:54:46.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:38:0) after 1m45s
[04:56:31.731] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:38:0)
[04:56:31.768] Build status: STARTED
[04:56:31.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:39:0) after 4m16s
[05:00:47.864] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:39:0)
[05:00:47.895] Build status: STARTED
[05:00:47.895] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8975401445637689840:40:0) after 7m18s
[05:06:17.348] Received PubSub notification, asking Buildbucket for the build status
[05:06:17.390] Build:
{
"id": "8809971383641769233",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 334,
"createdBy": "project:infra",
"createTime": "2022-06-30T01:46:25.354931767Z",
"startTime": "2022-06-30T01:48:17.017148Z",
"endTime": "2022-06-30T05:06:11.319831908Z",
"updateTime": "2022-06-30T05:06:11.319831908Z",
"status": "SUCCESS",
"input": {
}
}
[05:06:17.390] Invocation finished in 3h19m53.323059727s with status SUCCEEDED