[13:17:09.253] New invocation is queued and will start shortly
[13:17:09.253] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[13:17:10.337] Starting the invocation (attempt 1)
[13:17:10.368] Ignoring gitiles_ref tag without the buildset tag
[13:17:10.368] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:17:10.368] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:17:10.368] Buildbucket request:
{
"requestId": "8945460988306689648",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8945460988306689648",
"job": "infra/codesearch-gen-chromium-mac",
"triggers": [
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "75de97edd7fca72bdb611e3957cde8f6654d9b05",
"codesearch_mirror_revision_timestamp": 1685087974,
"root_solution_revision": "b0418665bc8d665ecc596a6ffeefc90f2f2a0a33",
"root_solution_revision_timestamp": 1685087785
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17360",
"user_agent:recipe"
]
},
"id": "4d472452-f667-4bad-9a1c-5bd42464c2eb",
"title": "codesearch-gen-chromium-initiator/17360"
},
{
"buildbucket": {
"properties": {
"codesearch_mirror_revision": "131eb03f815825c6641ddafb06335178c8a2d237",
"codesearch_mirror_revision_timestamp": 1685102376,
"root_solution_revision": "79d203e5d63487723ac7652e9b903b0b4395ae50",
"root_solution_revision_timestamp": 1685101965
},
"tags": [
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:17361",
"user_agent:recipe"
]
},
"id": "4011ed1a-4b78-48a2-9d86-8cad3b8d8852",
"title": "codesearch-gen-chromium-initiator/17361"
}
]
},
"codesearch_mirror_revision": "131eb03f815825c6641ddafb06335178c8a2d237",
"codesearch_mirror_revision_timestamp": 1685102376,
"root_solution_revision": "79d203e5d63487723ac7652e9b903b0b4395ae50",
"root_solution_revision_timestamp": 1685101965
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945460988306689648"
},
{
"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": "17361"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:17:10.811] Scheduled build:
{
"id": "8780030926398505265",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 2000,
"createdBy": "project:infra",
"createTime": "2023-05-26T13:17:10.449069395Z",
"updateTime": "2023-05-26T13:17:10.449069395Z",
"status": "SCHEDULED",
"input": {
}
}
[13:17:10.811] Task URL: https://cr-buildbucket.appspot.com/build/8780030926398505265
[13:17:10.811] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:2:0) after 4m27s
[13:19:51.042] Received PubSub notification, asking Buildbucket for the build status
[13:19:51.061] Build status: STARTED
[13:21:37.908] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:2:0)
[13:21:37.960] Build status: STARTED
[13:21:37.960] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:4:0) after 3m46s
[13:25:24.146] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:4:0)
[13:25:24.162] Build status: STARTED
[13:25:24.163] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:5:0) after 6m51s
[13:32:15.327] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:5:0)
[13:32:15.376] Build status: STARTED
[13:32:15.376] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:6:0) after 5m41s
[13:37:56.351] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:6:0)
[13:37:56.425] Build status: STARTED
[13:37:56.425] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:7:0) after 8m45s
[13:46:41.493] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:7:0)
[13:46:41.513] Build status: STARTED
[13:46:41.513] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:8:0) after 7m51s
[13:54:32.534] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:8:0)
[13:54:32.578] Build status: STARTED
[13:54:32.578] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:9:0) after 7m16s
[14:01:48.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:9:0)
[14:01:48.634] Build status: STARTED
[14:01:48.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:10:0) after 5m44s
[14:07:32.656] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:10:0)
[14:07:32.675] Build status: STARTED
[14:07:32.675] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:11:0) after 6m21s
[14:13:54.074] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:11:0)
[14:13:54.170] Build status: STARTED
[14:13:54.170] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:12:0) after 9m26s
[14:23:20.221] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:12:0)
[14:23:20.295] Build status: STARTED
[14:23:20.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:13:0) after 3m6s
[14:26:26.366] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:13:0)
[14:26:26.633] Build status: STARTED
[14:26:26.633] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:14:0) after 4m21s
[14:30:47.887] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:14:0)
[14:30:47.904] Build status: STARTED
[14:30:47.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:15:0) after 7m11s
[14:37:58.933] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:15:0)
[14:37:58.952] Build status: STARTED
[14:37:58.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:16:0) after 5m49s
[14:43:48.559] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:16:0)
[14:43:48.586] Build status: STARTED
[14:43:48.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:17:0) after 8m58s
[14:52:46.784] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:17:0)
[14:52:46.820] Build status: STARTED
[14:52:46.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:18:0) after 9m30s
[15:02:16.875] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:18:0)
[15:02:16.904] Build status: STARTED
[15:02:16.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:19:0) after 5m6s
[15:07:22.892] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:19:0)
[15:07:22.980] Build status: STARTED
[15:07:22.980] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:20:0) after 3m46s
[15:11:09.133] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:20:0)
[15:11:09.170] Build status: STARTED
[15:11:09.170] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:21:0) after 1m40s
[15:12:49.514] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:21:0)
[15:12:49.534] Build status: STARTED
[15:12:49.534] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:22:0) after 5m44s
[15:18:33.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:22:0)
[15:18:33.612] Build status: STARTED
[15:18:33.612] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:23:0) after 8m9s
[15:26:42.686] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:23:0)
[15:26:42.712] Build status: STARTED
[15:26:42.712] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:24:0) after 5m26s
[15:32:08.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:24:0)
[15:32:08.822] Build status: STARTED
[15:32:08.822] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:25:0) after 8m11s
[15:40:20.021] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:25:0)
[15:40:20.064] Build status: STARTED
[15:40:20.064] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:26:0) after 5m0s
[15:45:20.082] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:26:0)
[15:45:20.104] Build status: STARTED
[15:45:20.104] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:27:0) after 7m22s
[15:52:42.225] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:27:0)
[15:52:42.247] Build status: STARTED
[15:52:42.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:28:0) after 5m49s
[15:58:31.417] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:28:0)
[15:58:31.452] Build status: STARTED
[15:58:31.452] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:29:0) after 9m54s
[16:08:25.475] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:29:0)
[16:08:25.501] Build status: STARTED
[16:08:25.501] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:30:0) after 2m56s
[16:11:21.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:30:0)
[16:11:21.524] Build status: STARTED
[16:11:21.524] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:31:0) after 8m13s
[16:19:34.512] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:31:0)
[16:19:34.544] Build status: STARTED
[16:19:34.544] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:32:0) after 9m2s
[16:28:36.550] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:32:0)
[16:28:36.579] Build status: STARTED
[16:28:36.579] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:33:0) after 3m25s
[16:32:01.811] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:33:0)
[16:32:01.847] Build status: STARTED
[16:32:01.847] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:34:0) after 9m54s
[16:41:56.014] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:34:0)
[16:41:56.038] Build status: STARTED
[16:41:56.038] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:35:0) after 1m54s
[16:43:50.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:35:0)
[16:43:50.227] Build status: STARTED
[16:43:50.227] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:36:0) after 4m29s
[16:48:19.617] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:36:0)
[16:48:19.642] Build status: STARTED
[16:48:19.642] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:37:0) after 5m15s
[16:53:34.712] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:37:0)
[16:53:34.750] Build status: STARTED
[16:53:34.750] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:38:0) after 4m17s
[16:57:51.727] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:38:0)
[16:57:51.756] Build status: STARTED
[16:57:51.756] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:39:0) after 8m56s
[17:06:47.755] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:39:0)
[17:06:47.787] Build status: STARTED
[17:06:47.787] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:40:0) after 4m17s
[17:11:04.809] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:40:0)
[17:11:04.860] Build status: STARTED
[17:11:04.860] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:41:0) after 8m39s
[17:19:43.978] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:41:0)
[17:19:44.020] Build status: STARTED
[17:19:44.020] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:42:0) after 5m38s
[17:25:22.011] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:42:0)
[17:25:22.032] Build status: STARTED
[17:25:22.032] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:43:0) after 7m58s
[17:33:20.061] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:43:0)
[17:33:20.111] Build status: STARTED
[17:33:20.111] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:44:0) after 8m15s
[17:41:35.194] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:44:0)
[17:41:35.279] Build status: STARTED
[17:41:35.279] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:45:0) after 2m46s
[17:44:21.404] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:45:0)
[17:44:21.423] Build status: STARTED
[17:44:21.423] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:46:0) after 3m16s
[17:47:37.443] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:46:0)
[17:47:37.472] Build status: STARTED
[17:47:37.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:47:0) after 1m44s
[17:49:21.526] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:47:0)
[17:49:21.556] Build status: STARTED
[17:49:21.556] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:48:0) after 7m43s
[17:57:04.851] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:48:0)
[17:57:04.871] Build status: STARTED
[17:57:04.871] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:49:0) after 7m25s
[18:04:29.946] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:49:0)
[18:04:29.986] Build status: STARTED
[18:04:29.986] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:50:0) after 9m49s
[18:14:19.123] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:50:0)
[18:14:19.161] Build status: STARTED
[18:14:19.161] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:51:0) after 9m6s
[18:23:25.182] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:51:0)
[18:23:25.205] Build status: STARTED
[18:23:25.205] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:52:0) after 3m30s
[18:26:55.233] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:52:0)
[18:26:55.261] Build status: STARTED
[18:26:55.261] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:53:0) after 6m24s
[18:33:19.494] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:53:0)
[18:33:19.518] Build status: STARTED
[18:33:19.518] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:54:0) after 7m3s
[18:40:22.624] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:54:0)
[18:40:22.652] Build status: STARTED
[18:40:22.652] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:55:0) after 5m24s
[18:45:46.669] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:55:0)
[18:45:46.694] Build status: STARTED
[18:45:46.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:56:0) after 5m15s
[18:51:01.713] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:56:0)
[18:51:01.843] Build status: STARTED
[18:51:01.843] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:57:0) after 1m6s
[18:52:07.860] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:57:0)
[18:52:07.946] Build status: STARTED
[18:52:07.946] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:58:0) after 5m14s
[18:57:22.666] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:58:0)
[18:57:22.700] Build status: STARTED
[18:57:22.700] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-mac:8945460988306689648:59:0) after 9m15s
[19:04:56.026] Received PubSub notification, asking Buildbucket for the build status
[19:04:56.051] Build:
{
"id": "8780030926398505265",
"builder": {
"project": "infra",
"bucket": "codesearch",
"builder": "codesearch-gen-chromium-mac"
},
"number": 2000,
"createdBy": "project:infra",
"createTime": "2023-05-26T13:17:10.449069395Z",
"startTime": "2023-05-26T13:19:50.414281Z",
"endTime": "2023-05-26T19:04:55.722912537Z",
"updateTime": "2023-05-26T19:04:55.722912537Z",
"status": "SUCCESS",
"input": {
}
}
[19:04:56.051] Invocation finished in 5h47m46.805181412s with status SUCCEEDED